builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1447679915.35 results: success (0) buildid: 20151116030208 builduid: 1535f0fc9132460b9b4ed37dc4583e08 revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.351956) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.352406) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.352702) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009135 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.376685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.376997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.426485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.426740) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.480010) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.480283) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.480659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.480950) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 05:18:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-16 05:18:35 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.645688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.645984) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019765 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.695398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.695732) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 05:18:36,074 truncating revision to first 12 chars 2015-11-16 05:18:36,074 Setting DEBUG logging. 2015-11-16 05:18:36,074 attempt 1/10 2015-11-16 05:18:36,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 05:18:36,331 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.227252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.227558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.251231) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.251479) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.252031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-16 05:18:36.252354) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:36 INFO - MultiFileLogger online at 20151116 05:18:36 in /builds/slave/test-pgo 05:18:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:18:36 INFO - {'append_to_log': False, 05:18:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:18:36 INFO - 'blob_upload_branch': 'Firefox', 05:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:18:36 INFO - 'branch': 'Firefox', 05:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:36 INFO - 'config_files': ('talos/linux_config.py',), 05:18:36 INFO - 'default_actions': ('clobber', 05:18:36 INFO - 'read-buildbot-config', 05:18:36 INFO - 'download-and-extract', 05:18:36 INFO - 'populate-webroot', 05:18:36 INFO - 'create-virtualenv', 05:18:36 INFO - 'install', 05:18:36 INFO - 'run-tests'), 05:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:36 INFO - 'download_minidump_stackwalk': True, 05:18:36 INFO - 'download_symbols': 'ondemand', 05:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:36 INFO - 'installer_path': 'installer.exe', 05:18:36 INFO - 'log_level': 'info', 05:18:36 INFO - 'log_name': 'talos', 05:18:36 INFO - 'log_to_console': True, 05:18:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:36 INFO - 'opt_config_files': (), 05:18:36 INFO - 'pip_index': False, 05:18:36 INFO - 'sps_profile': False, 05:18:36 INFO - 'sps_profile_interval': 0, 05:18:36 INFO - 'suite': 'dromaeojs-e10s', 05:18:36 INFO - 'system_bits': '64', 05:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:36 INFO - 'title': 'talos-linux64-ix-016', 05:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:36 INFO - 'use_talos_json': True, 05:18:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:36 INFO - 'work_dir': 'build'} 05:18:36 INFO - ##### 05:18:36 INFO - ##### Running clobber step. 05:18:36 INFO - ##### 05:18:36 INFO - Running pre-action listener: _resource_record_pre_action 05:18:36 INFO - Running main action method: clobber 05:18:36 INFO - rmtree: /builds/slave/test-pgo/build 05:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - ##### 05:18:37 INFO - ##### Running read-buildbot-config step. 05:18:37 INFO - ##### 05:18:37 INFO - Running pre-action listener: _resource_record_pre_action 05:18:37 INFO - Running main action method: read_buildbot_config 05:18:37 INFO - Using buildbot properties: 05:18:37 INFO - { 05:18:37 INFO - "properties": { 05:18:37 INFO - "buildnumber": 543, 05:18:37 INFO - "product": "firefox", 05:18:37 INFO - "script_repo_revision": "production", 05:18:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:18:37 INFO - "repository": "", 05:18:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:18:37 INFO - "buildid": "20151116030208", 05:18:37 INFO - "slavename": "talos-linux64-ix-016", 05:18:37 INFO - "stage_platform": "linux64-pgo", 05:18:37 INFO - "basedir": "/builds/slave/test-pgo", 05:18:37 INFO - "nightly_build": "True", 05:18:37 INFO - "project": "", 05:18:37 INFO - "platform": "ubuntu64_hw", 05:18:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:18:37 INFO - "slavebuilddir": "test", 05:18:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:18:37 INFO - "branch": "mozilla-central", 05:18:37 INFO - "repo_path": "mozilla-central", 05:18:37 INFO - "pgo_build": "True", 05:18:37 INFO - "builduid": "1535f0fc9132460b9b4ed37dc4583e08", 05:18:37 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:37 INFO - }, 05:18:37 INFO - "sourcestamp": { 05:18:37 INFO - "repository": "", 05:18:37 INFO - "hasPatch": false, 05:18:37 INFO - "project": "", 05:18:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:18:37 INFO - "changes": [ 05:18:37 INFO - { 05:18:37 INFO - "category": null, 05:18:37 INFO - "files": [ 05:18:37 INFO - { 05:18:37 INFO - "url": null, 05:18:37 INFO - "name": "https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:18:37 INFO - } 05:18:37 INFO - ], 05:18:37 INFO - "repository": "", 05:18:37 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 05:18:37 INFO - "who": "sendchange", 05:18:37 INFO - "when": 1447679888, 05:18:37 INFO - "number": 6665698, 05:18:37 INFO - "comments": "", 05:18:37 INFO - "project": "", 05:18:37 INFO - "at": "Mon 16 Nov 2015 05:18:08", 05:18:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:18:37 INFO - "revlink": "", 05:18:37 INFO - "properties": [ 05:18:37 INFO - [ 05:18:37 INFO - "buildid", 05:18:37 INFO - "20151116030208", 05:18:37 INFO - "Change" 05:18:37 INFO - ], 05:18:37 INFO - [ 05:18:37 INFO - "builduid", 05:18:37 INFO - "1535f0fc9132460b9b4ed37dc4583e08", 05:18:37 INFO - "Change" 05:18:37 INFO - ], 05:18:37 INFO - [ 05:18:37 INFO - "nightly_build", 05:18:37 INFO - "True", 05:18:37 INFO - "Change" 05:18:37 INFO - ], 05:18:37 INFO - [ 05:18:37 INFO - "pgo_build", 05:18:37 INFO - "True", 05:18:37 INFO - "Change" 05:18:37 INFO - ] 05:18:37 INFO - ], 05:18:37 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:37 INFO - } 05:18:37 INFO - ], 05:18:37 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:37 INFO - } 05:18:37 INFO - } 05:18:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - ##### 05:18:37 INFO - ##### Running download-and-extract step. 05:18:37 INFO - ##### 05:18:37 INFO - Running pre-action listener: _resource_record_pre_action 05:18:37 INFO - Running main action method: download_and_extract 05:18:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:37 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json 05:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json 05:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:18:49 INFO - Downloaded 1302 bytes. 05:18:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:18:49 INFO - Using the following test package requirements: 05:18:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'jsshell-linux-x86_64.zip'], 05:18:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:18:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:18:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:49 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:55 INFO - Downloaded 22463059 bytes. 05:18:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:18:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:18:56 INFO - Return code: 0 05:18:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:56 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:19:01 INFO - Downloaded 22463059 bytes. 05:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:19:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:19:03 INFO - Return code: 0 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:19:04 INFO - Downloaded 11131693 bytes. 05:19:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:19:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:19:04 INFO - Return code: 0 05:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:04 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:19:06 INFO - Downloaded 57133317 bytes. 05:19:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:19:06 INFO - mkdir: /builds/slave/test-pgo/properties 05:19:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:19:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:19:06 INFO - Contents: 05:19:06 INFO - build_url:https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:19:06 INFO - Running post-action listener: _resource_record_post_action 05:19:06 INFO - Running post-action listener: set_extra_try_arguments 05:19:06 INFO - ##### 05:19:06 INFO - ##### Running populate-webroot step. 05:19:06 INFO - ##### 05:19:06 INFO - Running pre-action listener: _resource_record_pre_action 05:19:06 INFO - Running main action method: populate_webroot 05:19:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:19:06 INFO - '../fennec_ids.txt'], 05:19:06 INFO - 'tests': ['tcheck2']}, 05:19:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:06 INFO - '--tppagecycles', 05:19:06 INFO - '7'], 05:19:06 INFO - 'tests': ['tsvgm']}}, 05:19:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:19:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['damp', 'tps']}, 05:19:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['damp', 'tps']}, 05:19:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:19:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:06 INFO - 'other': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'other_l64': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'other_nol64': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore']}, 05:19:06 INFO - 'svgr': {'tests': ['tsvgx', 05:19:06 INFO - 'tsvgr_opacity', 05:19:06 INFO - 'tart', 05:19:06 INFO - 'tscrollx', 05:19:06 INFO - 'cart']}, 05:19:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['tsvgx', 05:19:06 INFO - 'tsvgr_opacity', 05:19:06 INFO - 'tart', 05:19:06 INFO - 'tscrollx', 05:19:06 INFO - 'cart']}, 05:19:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['tp5o']}, 05:19:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--e10s'], 05:19:06 INFO - 'tests': ['tp5o']}, 05:19:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--xperf_path', 05:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:06 INFO - 'tests': ['tp5n']}, 05:19:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--e10s', 05:19:06 INFO - '--xperf_path', 05:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:06 INFO - 'tests': ['tp5n']}}, 05:19:06 INFO - 'talos.zip': {'path': '', 05:19:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:06 INFO - Running post-action listener: _resource_record_post_action 05:19:06 INFO - ##### 05:19:06 INFO - ##### Running create-virtualenv step. 05:19:06 INFO - ##### 05:19:06 INFO - Running pre-action listener: _resource_record_pre_action 05:19:06 INFO - Running main action method: create_virtualenv 05:19:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:19:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:19:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:06 INFO - Using real prefix '/usr' 05:19:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:09 INFO - Installing pip.................done. 05:19:09 INFO - Return code: 0 05:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:19:09 INFO - Using env: {'DISPLAY': ':0', 05:19:09 INFO - 'HOME': '/home/cltbld', 05:19:09 INFO - 'LANG': 'en_US.UTF-8', 05:19:09 INFO - 'LANGUAGE': 'en_US:en', 05:19:09 INFO - 'LOGNAME': 'cltbld', 05:19:09 INFO - 'MAIL': '/var/mail/cltbld', 05:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:09 INFO - 'MOZ_NO_REMOTE': '1', 05:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:09 INFO - 'NO_EM_RESTART': '1', 05:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:09 INFO - 'SHELL': '/bin/bash', 05:19:09 INFO - 'SHLVL': '1', 05:19:09 INFO - 'TERM': 'linux', 05:19:09 INFO - 'TMOUT': '86400', 05:19:09 INFO - 'USER': 'cltbld', 05:19:09 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:09 INFO - '_': '/tools/buildbot/bin/python'} 05:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:19:09 INFO - Cleaning up... 05:19:09 INFO - Return code: 0 05:19:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:19:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:19:09 INFO - Using env: {'DISPLAY': ':0', 05:19:09 INFO - 'HOME': '/home/cltbld', 05:19:09 INFO - 'LANG': 'en_US.UTF-8', 05:19:09 INFO - 'LANGUAGE': 'en_US:en', 05:19:09 INFO - 'LOGNAME': 'cltbld', 05:19:09 INFO - 'MAIL': '/var/mail/cltbld', 05:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:09 INFO - 'MOZ_NO_REMOTE': '1', 05:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:09 INFO - 'NO_EM_RESTART': '1', 05:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:09 INFO - 'SHELL': '/bin/bash', 05:19:09 INFO - 'SHLVL': '1', 05:19:09 INFO - 'TERM': 'linux', 05:19:09 INFO - 'TMOUT': '86400', 05:19:09 INFO - 'USER': 'cltbld', 05:19:09 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:09 INFO - '_': '/tools/buildbot/bin/python'} 05:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:09 INFO - Downloading/unpacking psutil>=0.7.1 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:19:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:11 INFO - Installing collected packages: psutil 05:19:11 INFO - Running setup.py install for psutil 05:19:11 INFO - building 'psutil._psutil_linux' extension 05:19:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:19:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:19:11 INFO - building 'psutil._psutil_posix' extension 05:19:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:19:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:11 INFO - Successfully installed psutil 05:19:11 INFO - Cleaning up... 05:19:11 INFO - Return code: 0 05:19:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:19:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:19:11 INFO - Using env: {'DISPLAY': ':0', 05:19:11 INFO - 'HOME': '/home/cltbld', 05:19:11 INFO - 'LANG': 'en_US.UTF-8', 05:19:11 INFO - 'LANGUAGE': 'en_US:en', 05:19:11 INFO - 'LOGNAME': 'cltbld', 05:19:11 INFO - 'MAIL': '/var/mail/cltbld', 05:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:11 INFO - 'MOZ_NO_REMOTE': '1', 05:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:11 INFO - 'NO_EM_RESTART': '1', 05:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:11 INFO - 'SHELL': '/bin/bash', 05:19:11 INFO - 'SHLVL': '1', 05:19:11 INFO - 'TERM': 'linux', 05:19:11 INFO - 'TMOUT': '86400', 05:19:11 INFO - 'USER': 'cltbld', 05:19:11 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:11 INFO - '_': '/tools/buildbot/bin/python'} 05:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:19:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:19:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:19:13 INFO - Installing collected packages: mozsystemmonitor 05:19:13 INFO - Running setup.py install for mozsystemmonitor 05:19:13 INFO - Successfully installed mozsystemmonitor 05:19:13 INFO - Cleaning up... 05:19:14 INFO - Return code: 0 05:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:19:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:19:14 INFO - Using env: {'DISPLAY': ':0', 05:19:14 INFO - 'HOME': '/home/cltbld', 05:19:14 INFO - 'LANG': 'en_US.UTF-8', 05:19:14 INFO - 'LANGUAGE': 'en_US:en', 05:19:14 INFO - 'LOGNAME': 'cltbld', 05:19:14 INFO - 'MAIL': '/var/mail/cltbld', 05:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:14 INFO - 'MOZ_NO_REMOTE': '1', 05:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:14 INFO - 'NO_EM_RESTART': '1', 05:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:14 INFO - 'SHELL': '/bin/bash', 05:19:14 INFO - 'SHLVL': '1', 05:19:14 INFO - 'TERM': 'linux', 05:19:14 INFO - 'TMOUT': '86400', 05:19:14 INFO - 'USER': 'cltbld', 05:19:14 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:14 INFO - '_': '/tools/buildbot/bin/python'} 05:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:19:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:19:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:19:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:16 INFO - Downloading docopt-0.6.1.tar.gz 05:19:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:19:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:16 INFO - Running setup.py install for blobuploader 05:19:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:19:16 INFO - Running setup.py install for requests 05:19:17 INFO - Running setup.py install for docopt 05:19:17 INFO - Successfully installed blobuploader requests docopt 05:19:17 INFO - Cleaning up... 05:19:17 INFO - Return code: 0 05:19:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:19:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:17 INFO - Using env: {'DISPLAY': ':0', 05:19:17 INFO - 'HOME': '/home/cltbld', 05:19:17 INFO - 'LANG': 'en_US.UTF-8', 05:19:17 INFO - 'LANGUAGE': 'en_US:en', 05:19:17 INFO - 'LOGNAME': 'cltbld', 05:19:17 INFO - 'MAIL': '/var/mail/cltbld', 05:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:17 INFO - 'MOZ_NO_REMOTE': '1', 05:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:17 INFO - 'NO_EM_RESTART': '1', 05:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:17 INFO - 'SHELL': '/bin/bash', 05:19:17 INFO - 'SHLVL': '1', 05:19:17 INFO - 'TERM': 'linux', 05:19:17 INFO - 'TMOUT': '86400', 05:19:17 INFO - 'USER': 'cltbld', 05:19:17 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:17 INFO - '_': '/tools/buildbot/bin/python'} 05:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:17 INFO - Running setup.py (path:/tmp/pip-TUfICn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:17 INFO - Running setup.py (path:/tmp/pip-79cAzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:17 INFO - Running setup.py (path:/tmp/pip-LGPtdS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:17 INFO - Running setup.py (path:/tmp/pip-qo2Ppt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:17 INFO - Running setup.py (path:/tmp/pip-4rDIf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:17 INFO - Running setup.py (path:/tmp/pip-ZJT6w5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:17 INFO - Running setup.py (path:/tmp/pip-NakxUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:17 INFO - Running setup.py (path:/tmp/pip-augsxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:17 INFO - Running setup.py (path:/tmp/pip-yHweTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:18 INFO - Running setup.py (path:/tmp/pip-AFizla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:18 INFO - Running setup.py (path:/tmp/pip-KP0Vzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:18 INFO - Running setup.py (path:/tmp/pip-ynKYvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:18 INFO - Running setup.py (path:/tmp/pip-FglGrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:18 INFO - Running setup.py (path:/tmp/pip-11KM8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:18 INFO - Running setup.py (path:/tmp/pip-b6AtbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:18 INFO - Running setup.py (path:/tmp/pip-DwLLEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:18 INFO - Running setup.py (path:/tmp/pip-NbubJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:18 INFO - Running setup.py install for manifestparser 05:19:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:19:18 INFO - Running setup.py install for mozcrash 05:19:18 INFO - Running setup.py install for mozdebug 05:19:18 INFO - Running setup.py install for mozdevice 05:19:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:19:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozfile 05:19:19 INFO - Running setup.py install for mozhttpd 05:19:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozinfo 05:19:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozInstall 05:19:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozleak 05:19:19 INFO - Running setup.py install for mozlog 05:19:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for moznetwork 05:19:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozprocess 05:19:19 INFO - Running setup.py install for mozprofile 05:19:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:19:19 INFO - Running setup.py install for mozrunner 05:19:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:19:20 INFO - Running setup.py install for mozscreenshot 05:19:20 INFO - Running setup.py install for moztest 05:19:20 INFO - Running setup.py install for mozversion 05:19:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:19:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:20 INFO - Cleaning up... 05:19:20 INFO - Return code: 0 05:19:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:19:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:20 INFO - Using env: {'DISPLAY': ':0', 05:19:20 INFO - 'HOME': '/home/cltbld', 05:19:20 INFO - 'LANG': 'en_US.UTF-8', 05:19:20 INFO - 'LANGUAGE': 'en_US:en', 05:19:20 INFO - 'LOGNAME': 'cltbld', 05:19:20 INFO - 'MAIL': '/var/mail/cltbld', 05:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:20 INFO - 'MOZ_NO_REMOTE': '1', 05:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:20 INFO - 'NO_EM_RESTART': '1', 05:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:20 INFO - 'SHELL': '/bin/bash', 05:19:20 INFO - 'SHLVL': '1', 05:19:20 INFO - 'TERM': 'linux', 05:19:20 INFO - 'TMOUT': '86400', 05:19:20 INFO - 'USER': 'cltbld', 05:19:20 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:20 INFO - '_': '/tools/buildbot/bin/python'} 05:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:20 INFO - Running setup.py (path:/tmp/pip-P9itdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:20 INFO - Running setup.py (path:/tmp/pip-DUW450-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:20 INFO - Running setup.py (path:/tmp/pip-76ywH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:20 INFO - Running setup.py (path:/tmp/pip-2oHI8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:20 INFO - Running setup.py (path:/tmp/pip-ZnAiMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:20 INFO - Running setup.py (path:/tmp/pip-2LMsQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:21 INFO - Running setup.py (path:/tmp/pip-kHtC7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:21 INFO - Running setup.py (path:/tmp/pip-YbZTln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:21 INFO - Running setup.py (path:/tmp/pip-23WvEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:21 INFO - Running setup.py (path:/tmp/pip-n56kYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:21 INFO - Running setup.py (path:/tmp/pip-Wvytsb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:21 INFO - Running setup.py (path:/tmp/pip-fp5UlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:21 INFO - Running setup.py (path:/tmp/pip-XwjnpZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:21 INFO - Running setup.py (path:/tmp/pip-yIKRz0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:21 INFO - Running setup.py (path:/tmp/pip-sqM9Oa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:21 INFO - Running setup.py (path:/tmp/pip-HhjX3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:21 INFO - Running setup.py (path:/tmp/pip-tkQZUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:23 INFO - Downloading blessings-1.5.1.tar.gz 05:19:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:19:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:23 INFO - Installing collected packages: blessings 05:19:23 INFO - Running setup.py install for blessings 05:19:23 INFO - Successfully installed blessings 05:19:23 INFO - Cleaning up... 05:19:23 INFO - Return code: 0 05:19:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:19:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:19:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:19:23 INFO - Reading from file tmpfile_stdout 05:19:23 INFO - Current package versions: 05:19:23 INFO - argparse == 1.2.1 05:19:23 INFO - blessings == 1.5.1 05:19:23 INFO - blobuploader == 1.2.4 05:19:23 INFO - docopt == 0.6.1 05:19:23 INFO - manifestparser == 1.1 05:19:23 INFO - mozInstall == 1.12 05:19:23 INFO - mozcrash == 0.16 05:19:23 INFO - mozdebug == 0.1 05:19:23 INFO - mozdevice == 0.47 05:19:23 INFO - mozfile == 1.2 05:19:23 INFO - mozhttpd == 0.7 05:19:23 INFO - mozinfo == 0.9 05:19:23 INFO - mozleak == 0.1 05:19:23 INFO - mozlog == 3.0 05:19:23 INFO - moznetwork == 0.27 05:19:23 INFO - mozprocess == 0.22 05:19:23 INFO - mozprofile == 0.27 05:19:23 INFO - mozrunner == 6.11 05:19:23 INFO - mozscreenshot == 0.1 05:19:23 INFO - mozsystemmonitor == 0.0 05:19:23 INFO - moztest == 0.7 05:19:23 INFO - mozversion == 1.4 05:19:23 INFO - psutil == 3.1.1 05:19:23 INFO - requests == 1.2.3 05:19:23 INFO - wsgiref == 0.1.2 05:19:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe70568fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x299d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:19:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:23 INFO - Using env: {'DISPLAY': ':0', 05:19:23 INFO - 'HOME': '/home/cltbld', 05:19:23 INFO - 'LANG': 'en_US.UTF-8', 05:19:23 INFO - 'LANGUAGE': 'en_US:en', 05:19:23 INFO - 'LOGNAME': 'cltbld', 05:19:23 INFO - 'MAIL': '/var/mail/cltbld', 05:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:23 INFO - 'MOZ_NO_REMOTE': '1', 05:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:23 INFO - 'NO_EM_RESTART': '1', 05:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:23 INFO - 'SHELL': '/bin/bash', 05:19:23 INFO - 'SHLVL': '1', 05:19:23 INFO - 'TERM': 'linux', 05:19:23 INFO - 'TMOUT': '86400', 05:19:23 INFO - 'USER': 'cltbld', 05:19:23 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:23 INFO - '_': '/tools/buildbot/bin/python'} 05:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19:24 INFO - Cleaning up... 05:19:24 INFO - Return code: 0 05:19:24 INFO - Running post-action listener: _resource_record_post_action 05:19:24 INFO - Running post-action listener: _start_resource_monitoring 05:19:24 INFO - Starting resource monitoring. 05:19:24 INFO - ##### 05:19:24 INFO - ##### Running install step. 05:19:24 INFO - ##### 05:19:24 INFO - Running pre-action listener: _resource_record_pre_action 05:19:24 INFO - Running main action method: install 05:19:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:19:24 INFO - Reading from file tmpfile_stdout 05:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:19:24 INFO - Reading from file tmpfile_stdout 05:19:24 INFO - Output received: 05:19:24 INFO - Usage: mozinstall [options] installer 05:19:24 INFO - Options: 05:19:24 INFO - -h, --help show this help message and exit 05:19:24 INFO - -d DEST, --destination=DEST 05:19:24 INFO - Directory to install application into. [default: 05:19:24 INFO - "/builds/slave/test-pgo"] 05:19:24 INFO - --app=APP Application being installed. [default: firefox] 05:19:24 INFO - mkdir: /builds/slave/test-pgo/build/application 05:19:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:19:38 INFO - Reading from file tmpfile_stdout 05:19:38 INFO - Output received: 05:19:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:19:38 INFO - Running post-action listener: _resource_record_post_action 05:19:38 INFO - ##### 05:19:38 INFO - ##### Running run-tests step. 05:19:38 INFO - ##### 05:19:38 INFO - Running pre-action listener: _resource_record_pre_action 05:19:38 INFO - Running main action method: run_tests 05:19:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:19:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:19:38 INFO - Python 2.7.3 05:19:38 INFO - Return code: 0 05:19:38 INFO - grabbing minidump binary from tooltool 05:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a268c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d38b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:19:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:19:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:19:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:38 INFO - Return code: 0 05:19:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:19:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:19:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:19:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 05:19:38 INFO - Using env: {'DISPLAY': ':0', 05:19:38 INFO - 'HOME': '/home/cltbld', 05:19:38 INFO - 'LANG': 'en_US.UTF-8', 05:19:38 INFO - 'LANGUAGE': 'en_US:en', 05:19:38 INFO - 'LOGNAME': 'cltbld', 05:19:38 INFO - 'MAIL': '/var/mail/cltbld', 05:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:38 INFO - 'MOZ_NO_REMOTE': '1', 05:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:38 INFO - 'NO_EM_RESTART': '1', 05:19:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:19:38 INFO - 'SHELL': '/bin/bash', 05:19:38 INFO - 'SHLVL': '1', 05:19:38 INFO - 'TERM': 'linux', 05:19:38 INFO - 'TMOUT': '86400', 05:19:38 INFO - 'USER': 'cltbld', 05:19:38 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447674972.329631-385099137', 05:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:38 INFO - '_': '/tools/buildbot/bin/python'} 05:19:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 05:19:39 INFO - mozversion INFO | application_buildid: 20151116030208 05:19:39 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:19:39 INFO - mozversion INFO | application_display_name: Nightly 05:19:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:39 INFO - mozversion INFO | application_name: Firefox 05:19:39 INFO - mozversion INFO | application_remotingname: firefox 05:19:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:19:39 INFO - mozversion INFO | application_vendor: Mozilla 05:19:39 INFO - mozversion INFO | application_version: 45.0a1 05:19:39 INFO - mozversion INFO | platform_buildid: 20151116030208 05:19:39 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:19:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:19:39 INFO - mozversion INFO | platform_version: 45.0a1 05:19:39 INFO - 2015-11-16 05:19:39,171 DEBUG : using testdate: 1447679979 05:19:39 INFO - 2015-11-16 05:19:39,171 DEBUG : actual date: 1447679979 05:19:39 INFO - 2015-11-16 05:19:39,219 INFO : starting webserver on 'localhost:34899' 05:19:39 INFO - 2015-11-16 05:19:39,220 INFO : Starting test suite talos-linux64-ix-016.e 05:19:39 INFO - 2015-11-16 05:19:39,220 INFO : Starting test dromaeo_css 05:19:39 INFO - 2015-11-16 05:19:39,220 DEBUG : operating with platform_type : linux_ 05:19:39 INFO - 2015-11-16 05:19:39,221 INFO : Initialising browser for dromaeo_css test... 05:19:39 INFO - 2015-11-16 05:19:39,235 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPWkRNn/profile http://localhost:34899/getInfo.html 05:19:43 INFO - 2015-11-16 05:19:43,988 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:19:43 INFO - 2015-11-16 05:19:43,988 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:19:43 INFO - 2015-11-16 05:19:43,988 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:19:43 INFO - 2015-11-16 05:19:43,988 DEBUG : BROWSER_OUTPUT: __metrics 05:19:44 INFO - 2015-11-16 05:19:44,997 INFO : Browser initialized. 05:19:44 INFO - 2015-11-16 05:19:44,998 INFO : Running cycle 1/1 for dromaeo_css test... 05:19:44 INFO - 2015-11-16 05:19:44,998 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPWkRNn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:19:56 INFO - 2015-11-16 05:19:56,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 05:19:56 INFO - 2015-11-16 05:19:56,869 DEBUG : BROWSER_OUTPUT: 05:20:46 INFO - 2015-11-16 05:20:46,480 DEBUG : BROWSER_OUTPUT: 1447680046477 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:22:55 INFO - 2015-11-16 05:22:55,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34899/tests/dromaeo/cssquery-ext.html) 05:22:56 INFO - 2015-11-16 05:22:56,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 145735680 05:22:56 INFO - 2015-11-16 05:22:56,165 DEBUG : BROWSER_OUTPUT: 05:25:58 INFO - 2015-11-16 05:25:58,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-ext.html (next: http://localhost:34899/tests/dromaeo/cssquery-jquery.html) 05:25:58 INFO - 2015-11-16 05:25:58,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 05:25:58 INFO - 2015-11-16 05:25:58,647 DEBUG : BROWSER_OUTPUT: 05:29:00 INFO - 2015-11-16 05:29:00,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34899/tests/dromaeo/cssquery-mootools.html) 05:29:00 INFO - 2015-11-16 05:29:00,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 141307904 05:29:00 INFO - 2015-11-16 05:29:00,877 DEBUG : BROWSER_OUTPUT: 05:32:02 INFO - 2015-11-16 05:32:02,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34899/tests/dromaeo/cssquery-prototype.html) 05:32:03 INFO - 2015-11-16 05:32:03,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 140488704 05:32:03 INFO - 2015-11-16 05:32:03,106 DEBUG : BROWSER_OUTPUT: 05:35:05 INFO - 2015-11-16 05:35:05,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34899/tests/dromaeo/cssquery-yui.html) 05:35:06 INFO - 2015-11-16 05:35:06,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 140800000 05:35:06 INFO - 2015-11-16 05:35:06,042 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/dromaeo/cssquery-yui.html (next: http://localhost:34899/tests/dromaeo/cssquery-dojo.html) 05:38:08 INFO - 2015-11-16 05:38:08,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 142508032 05:38:08 INFO - 2015-11-16 05:38:08,531 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,531 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:38:08 INFO - 2015-11-16 05:38:08,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:38:08 INFO - 2015-11-16 05:38:08,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:38:08 INFO - 2015-11-16 05:38:08,531 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:38:08 INFO - 2015-11-16 05:38:08,535 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3191.6648751881053;3227.661095584965;3251.1221970068095;3273.52533882587;3275.934481310374;5280.260763493105;5378.704171270583;5461.918071228934;5465.590080743945;5476.931998260341;5352.732363381835;5357.035733567956;5392.056390131721;5446.400895901447;5464.781408743655;4688.624910007208;4930.852074437764;5175.974120129413;5179.223116532513;5181.715005674687;4907.043126590316;5095.770690318926;5120.411152717448;5124.052050370675;5189.8183563575285;4868.975655121737;4965.925511117336;4993.151164302078;4995.075910956485;5032.446430892599;4935.333729946483;4939.333190019373;4941.209406494943;4966.776495057731;4993.825216117419;4827.08285425768;4914;4914.680545764514;4921.089598424303;4986.10250154972;5218.608604354688;5249.1338929076655;5258.290130832327;5272.420033796279;5357.08929481989;5863.442972917609;5872.442117998826;5875.2949646042325;5876.911846322266;5877.118432235156;5734.684592347419;5844.415558444164;5847.883042339172;5865.794697185621;5880.147378630118;5397.541208997279;5446.373667028263;5462.0441422751255;5478.287822583078;5479.945200547983;5939.495142912814;5950.851228719317;5970.731317090741;6006.789762358297;6011.218541589566;5813.970930145322;5825.76696932118;5830.82507524775;5833.212516310244;5839.620424672383;5706.3722990471015;5808.448197421239;5809.82570522885;5872.7357268923;5905.586608937333;5785.392533783976;5901.439363260483;5916.940830591725;5926.051831706906;5939.4951429129005;5851.297844258631;5876.236089308362;5884.882302353929;5914.526837852962;5917.082852157922;4371.497277813029;4414.977925110418;4487.461504619467;4505.5269196734525;4547.727136371828;4038.414429907647;4041.7574945503366;4051.1897620476025;4080.10237747695;4086.775227362464;5550.333959924754;5655.886882262332;5663.178839068312;5668.801591944345;5674.120511320752;5800.24596802413;5925.466707996301;5928.318243401977;5929.762809487658;5930.110483427434;5635.830925072254;5640.633358831663;5644.858878527987;5648.8870222595315;5675.716214189274;5096.261042148942;5106.412762532356;5108.821191258363;5126.461721519261;5148.4851514848215;5962.403759624003;6046.637201767908;6047.576669633171;6052.152698622196;6117.816465506042;5814.622049566765;5887.970560147171;5900.734466949083;5932.614380065282;5989.850253743692;6029.728662210299;6117.3270940197435;6119.785807496716;6138.355472675305;6144.907826382519;5682.119271512922;5744.626599271034;5779.884402311846;5842.298924129132;5842.941570584409;5878.794242201502;5884.558658100746;5893;5911.674857882857;5922.644641321534;5703.714814259188;5703.971480142573;5712.685802280915;5748.827535173951;5756.107803290497;5644.322681278109;5652.943470565242;5724.026915424472;5784.929787989067;5792.9710351447975;5725.370209276893;5729.255196824386;5741.4832665058675;5768.423157684198;5770.769169233184;5820.650760954187;5858.853528661817;5869.911951320819;5902.6458412495385;5908.852278692895;5446.264754258283;5529.529989950899;5593.328800543798;5684.8294551163535;5709.942900571107 05:38:08 INFO - 2015-11-16 05:38:08,538 DEBUG : BROWSER_OUTPUT: |1;ext.html;582.0890306670061;592.552622769809;593.0896074525599;595.9374265702102;606.3784620763716;35138.824305878465;36067.2786544269;36300.636993630054;36428.63571364289;36434;41646.16707665845;42263.78868105663;42498.36252456216;42526.362104568376;42597;8864.689735859247;8994.055624159468;9015.233705135071;9031.729048128567;9033.638654453815;8745.606447709868;8783.692570760024;8798.6920457784;8821.338399620023;8859.734207973772;8778.64885404583;8792.780180495507;8829.293656507496;8834.734957951272;8878.156575125353;8727.170918762708;8842.336824738139;8847.867281990775;8855.424397414148;8872.822543549093;8712.912870871274;8854.822903541894;8861.512616806072;8877;8878.86681699775;38928.22143557142;39568;39574.60425395738;39610.60389396098;39624.405633915514;3192.776505644606;3204.8718051278156;3238.5627940228237;3243.383757086146;3347.5146103815055;29291;29645.45490679278;29842.70157298421;30067.69932300671;30345.848270758725;3353.7484688648206;3357.529945807589;3376.0418957004877;3378.294581334554;3391.16916355492;275912;276220.61889690626;276574;276788;277268;41305.38041929373;55727.72136139374;56056.71971640116;56164.71917640386;56194.438055619736;40822.79588602038;40827.59172408238;40913.38629920554;40927;41004.38493422601;13182.143160694524;13283.070185087145;13315.334233288297;13341.19952802835;13401.597952061455;10424.635137770141;10443.791124177475;10475.84286235707;10490;10536.683899483029;13881.791773123412;13901.235432051131;14039.50861719835;14215.218163000927;14276.857231427553;5786.739596718157;5838.7080645967535;5871.915470008171;5913.881722365529;5986.73059712314;942.9764255893521;969.471637957315;1022.8414595737672;1070.7055559720984;1141.8972292493715;27748.86125569359;28469.145925622266;28494.717737701852;32079.51880721791;32355.838220808746;1030.9278350515392;1035.7307100154014;1039.2205845615788;1042.8331466965249;1051.7160366700948;13064.804027939588;13110.939099603102;13144.882684971693;13185.60443186706;13224.801627975588;403050;408792;409458;412737;414578;51745.48254517482;52129.2180617291;52180.73909630428;52224.216636750476;52492.21261681078;1339.6650837290676;1341.8322709661293;1348.9208633093485;1351.2703140304125;1354.0386325708857;24333.878330608233;25081.623775643744;25242.747572524775;25324.49351013006;25532.61701074448;41998.1600367997;42794.5720542803;42830.78584607182;42841.357379638706;42873;296282;296968;298720;299023;299640;31707;45109.0978180428;45258.53901770132;46282.537174627825;46368;42783.35824962566;42906.14187716166;43069.569304306555;43591;44046.559534404245;36131.81934090313;36949.27434970898;37324;37385.2522949534;37743;36262.27475450529;36839.3422295992;36862.44706329461;37078.44382334321;37250.06874828151;34932.47601286034;35394.8230258847;35693.28613427769;35703.46444803382;36013.81993090018;30777.384452311275;33438.66561334355;33806.830965845016;33832.66167338295;33956;26590.468190636468;27727;27730.722692773623;27768.305792355353;27811.165665030083 05:38:08 INFO - 2015-11-16 05:38:08,538 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.698326031681;343.9931201375971;346.02420180767814;346.7884590399856;348.1557223732448;12651.683707907307;13057.086003979724;13731.244781537023;15567.221638918065;16361.590960226;11327.943360283187;11442.485088171052;11547.191696581243;11834.881651183485;11854.881451185485;4561.178987782189;4638;4664.603508701764;4693.037927224927;4695.741734204617;4347.543507931669;4350.934735978963;4357.934630980538;4364.432623758907;4390.692651514395;4519.954800452003;4585.014221942299;4590.839320623779;4734.90530189396;4880;4810.518948105161;4822.638302127354;4825.589824864891;4856.17445034345;4865.8783530411665;4077.3680079587416;4322.157179350028;4322.524522302544;4331.242032644306;4332.870013899588;13196.340182990813;13259.801102983463;13492.730145397038;13888.513902013381;13953.581392558139;1985.3349128042123;2038.8878611676353;2047.129969762845;2082.8437867160023;2084.5050793634987;10184.898151018544;10198.745031374201;10201.489925503694;10329.225308101923;10425.113865321457;1663.4760050584148;1682.7055265328518;1690.7717458143115;1718.321263101068;1723.5087999920088;57274;58516.122258166586;59717.7014114931;59794.40205597932;59824.40175598232;6899.344562266577;6984.2317345092;7059.505834591632;7125.679344429514;7183.820404489929;8517.190866867637;8547.82904341922;8578.18507241811;8589.570521473901;8599.441036332619;5471.781128754885;5487.725613719298;5489;5518.117101263859;5521.834344969658;5512.035393806148;5551.8889622207325;5554.472325129106;5601.831945041574;5607.551395888319;3283.326917981856;3293.92947292131;3301.5047742838765;3328.7004169624365;3338.115399419156;1165.44641295384;1165.7143999720122;1170.4908364861312;1186.8813118688236;1220.17638094286;450.662003497377;484.60988903932673;510.25757522804975;513.2019709351919;520.2508387921381;11256.718582035515;11428.314301141958;11530.76938461226;11646.36950826885;11757.059435245159;500.68707058088694;508.8397154896196;510.6859281541899;516.2256615077384;521.6583138044587;6369.681515924185;6492.253390860017;6504.089427480157;6589.6375699336995;6608.537402381883;507762;513844;519121;520084;520597;72819.27180728124;73080;73912.26087739161;74989.62505187548;76697;559.2394343692575;559.5439716630933;560.742058653016;560.8429639700972;562.6680258647336;10641.361518308926;10910.61812836547;11082.113430925669;11179.385133817717;11181.776364472502;32716.672833272314;32753;32786;33385.499217512246;33485.33029339448;45656;46341.304880427495;46451;47470;47682.761586193235;6923.5499692519825;6972.860542789217;6979.057827193467;6986.091808064919;7034.050403195503;12385.318807465315;12711.300878451773;12763.553275635679;12794.936025320187;12897.161684490478;8767.386282960386;8882.62002900726;10373.58505659765;10736.946315268373;10783.676489705322;10068.69793906184;10642.521086550969;10665.680029599125;10919.454027298762;11215.943920280346;10590.841137382791;10864.293820901616;10934.125269978542;11011.174161937726;11334.886651133713;6868.523267497512;6948.687309071205;7006.6846991886505;7014.0531028310525;7015.473839462163;10565.788684226427;10772.461376930965;10876.401797901191;11027.117830573696;11089.5564177432 05:38:08 INFO - 2015-11-16 05:38:08,539 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1442.4014034175816;1507.3066389460844;1590.1492701404736;1617.975730364044;1736.3835838277412;6728;6871.759488417906;7222.711091556338;7412.592307423083;7430.851382972337;7070.964645176779;7110.964445177767;7249.891251631229;7249.963750181255;7256.709731610729;2179.6621523663857;2213.380253529014;2218.223621732397;2219.234364144376;2227.307246492669;2209.3924170852983;2242.6636004599277;2243.1139699818564;2246.29241788836;2258.096761295487;2206.680031395447;2231.040652519424;2237.742659594143;2256.26671331817;2275.7155355580553;2109.2512158183777;2125.3517677108475;2147.1304121830603;2148.0655914677163;2151.580441813847;2213.1147540983575;2213.966790498144;2224.088123869206;2232.0179121186625;2238.7649296823924;7385.335319821242;7397.889031664529;7437.99587055746;7460.552366858006;7479.887801682979;4388.868333949987;4462.843800467001;4467.932981005288;4479.798409071567;4483.910321793546;2857.6999415061327;2945.617069780936;2953.8080024798533;2954.1285320830407;2967.109867039901;918.1736437206567;933.4912472702393;940.2618944128894;960.8894977077656;978.1636700620937;9823.312368134304;9883.308168428213;9907.356021858555;9910.454924979123;9965.20278377728;4186.204621121977;4193.433886425354;4224.5353011168745;4233.534311225824;4241.575842415734;8506.957465212634;8510;8518.190771876662;8529.360297977677;8574.27118694918;4469.41897553316;4515.029268707178;4515.796789144496;4524.773761311922;4525.52481989393;3607.1162565171703;3689.2990331836863;3996.6003399659803;4078;4081.89795255121;3566.7859928404378;3580.230250496156;3654.7624404413627;3661.2860492204295;3673.393890008172;1166.6150170443734;1169.4562028656715;1174.5712814822527;1178.3695722788268;1200.1059210887945;1082.929609575375;1094.5676457799284;1102.6030628973563;1236.8330275412704;1326.323574976769;6910.2744211858035;6948.44412447003;6974.825629359205;6978.546394484342;7008.5094043416475;469.67123013890415;473.76785375165923;474.41172945547964;475.9714417134983;476.62822998060875;5504.834854954358;5528.170774383794;5550.750216240279;5552.888942221133;5564.10974244119;8533.573321333908;8612.741617751477;8617.224449799549;8710.912890871137;8737.956310218535;8379.664813407517;8446.197611226924;8551.828963420698;8565.871511927326;8574.657013719507;6745.258021617618;6787.287334829772;6788.253292137861;6845.0759147514445;6849.04113424121;6223.906641400473;6332.493400528039;6382.36176382358;6391.392817682313;6402.199725034371;7483.214262502359;7583.848323033398;7593.240675932362;7610.238976102345;7752.689892404241;7860.882086768589;7869.409794265339;7886.921130788848;7930.286274235346;7987.201279871966;6341.270753863365;6432.935670643234;6658.067870498037;6705.731770729116;6754.729810807513;7269.672864720995;7316.158641756266;7317.121945366377;7349;7358.77923662291;6781.42357899584;6801.387875091265;6813.4549236061985;7034.718611255493;7045.1898031727005;6734.22556406;6791.45668346541;6794.048833163262;6913.861722765617;6952.756653517103;6650.9667451662435;6688.6990085445295;6704.530682852349;6745.797626071226;6765.2896445872475;6265.686715664107;6274.372562743689;6282.654454004891;6309.716062777278;6321.747130114928;6010.9699451502465;6082.5438092142385;6082.543809214415;6082.90507708599;6092.421219984094 05:38:08 INFO - 2015-11-16 05:38:08,541 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.4072817278135;309.8667572943635;310.8119587649472;316.7560978046904;317.25445203771125;6222.097795819604;6343.429091381775;6368.395002474769;6408.839779005515;6421.8715625687455;6279.780207692732;6307.085472606469;6309.905351419732;6328.493720502361;6336.588121772082;4707.05858828234;4759.690620109699;4791.544803243686;4799.976000119995;4808.567228949394;4787.449443314012;4803.2795080738;4817.181079216524;4852.563269305761;4866.756662166895;4784.043191361724;4791.520847915215;4797;4798.616110711135;4811.59101476375;4778.235482322829;4796.592289655384;4801.375821143247;4815;4818.542238487338;4099.139180772041;4175.832966681329;4190.329547272422;4194.266003449415;4205.474315710536;5956.821295361103;5999.310079340888;6025.397460253984;6026.126211699279;6027.849303767441;5552.222688823527;5593.74828132735;5602.7758889644365;5606.999999999959;5614.29821272341;6617.172853393326;6706;6727.596344219313;6732.427743641796;6746.494012949049;4550.408446901882;4589.747563883985;4598.3102534620075;4600.6549508786975;4602.401687780601;6925.965370173117;6940.930590694079;6951.860962780716;6986;6986.580805151656;4678.017616300547;4679.087577922341;4694.037722266927;4697.6711630185555;4697.976510117427;4652.488226295105;4737.526247375235;4740.502247264057;4751.572358487752;4758.214894542361;5523.530499907472;5538.529225015838;5540.612157148961;5542.473465020817;5544.085225937756;6803.591784492946;6812.14848143982;6816.829579260459;6821.658917054227;6828;1641.7537369394447;1675.7235056215832;1677.429673910876;1680.4034567728525;1681.1678219281534;1098.280626189847;1104.9060829829555;1110.4780753046055;1121.6018313498753;1157.2767020612118;6421.967890160519;6515.934840651627;6517.217933847968;6531.575447595891;6536.509761767887;6994.720211191597;7026.754063607851;7060.752873649398;7065.6113913735235;7067.469939754436;6550.574212676161;6606;6607.306232845578;6614.603123812587;6624.867502650017;3750.849966001384;3789.317922773872;3795.582485926546;3821.3121638104853;3831.3295173344554;7362.44781641379;7370.078740157481;7375.668094935741;7399.963000185072;7422.220666830013;7207.495475316782;7235.638218089074;7244.710211591583;7245.8550828983125;7285.7814265572115;7145.249748776408;7309;7333.4499912507845;7356.043714317211;7357.3378395943555;7045.978333141563;7048.823779405351;7049.224585295511;7062.540934839219;7078.8938165928585;6962.3037696231995;6983.930160698531;6989.475789315923;7016.22821489646;7031.402330801735;7244.384227340735;7380.298871607189;7382.889256661047;7400.925990740024;7407.518511296748;4523.2988886722615;4591.127685739699;4609.446866375923;4615.907681846412;4618.815247390201;6999.0551275577145;6999.160100787938;7069.116360454943;7071.7878463646175;7081.752138675121;6684.4318232950745;6798.320167983162;6815;6832.965835170792;6841.657917104224;6791.626460544718;6793.66031698423;6810.421114205348;6819.522633415613;6844.760433385007;6566.606003639797;6634.867302654016;6681.532292739462;6681.732730690718;6695.866082678416;6679.365460281266;6827.2490026098085;6832.863342733018;6836.521443499107;6840.760573379908;6544.476441884733;6609.20689517261;6610.8016759497295;6627.1716035495565;6666.400023997863 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.857092866891;740.8296091898864;754.6151462753994;849.8215374771298;861.9784505387366;13503.122297050684;13669;13703.520376786815;13755;13755.243461609607;13009.609711708641;13140.540081097164;13163.868361316385;14068.155910645368;14136;799.9960000199991;806.7499075286651;807.0476837331946;808.2321794295414;808.8665370213907;814.1288820961544;814.5967745965755;815.213319147023;816.8039670479102;819.7581713394533;848.440029580477;849.0448245723561;852.4842470305468;853.0190281176634;855.8117214212863;843.8987321521396;846.4371193156605;849.0914721248267;849.1296421168321;857.8069934264803;619.0806652121596;622.2129006806393;623.8190924631851;623.9032949892728;627.8587317853492;12764.680882977907;12782.552610658675;12796.872031279754;12903.612891613267;12920.741585168244;10912.781744365147;11025.724356891062;11083.224174307801;11089.611863584736;11202.439878006067;9675.274354423447;9710.320277580573;9710.368826026286;9843.458609776459;9852;3441.208522039945;3547.130952916526;3567.8751243706347;3678.6873115785193;3764.2471505698695;42247.155056899;43442.34836477455;47677;47707.28439073417;49062.26406603904;9159.862602060974;9334.20659243972;9381.90618093824;9444.622215111456;9452.43285402878;17503.73744393835;18037.098145092692;18039.203923391895;18100.45698629043;18153;7801.843963120706;7831.6475758591005;7841.372690184771;7869.1737367576725;7961.084475285416;4231.217224813419;4281.892952676208;4349.521552629209;4365.934510982338;4390.846320378771;2960.733533981952;2962.555616657519;2968.495355789521;2974.568687540338;2980.1208643450236;469.38979326874926;470.4448750474473;473.37987236720005;474.29803890242636;480.0878331170803;569.9401562835925;641.9807405777834;665.125360151409;673.5083389125867;681.1621705302506;8374;8512.361572882059;8625.223729864343;8632.179942905414;8690.08754080825;525.1204232909861;539.6487810695625;624.781326535718;637.4390536328002;671.6473851228046;3768;3769.8115094245177;3777.58446570877;3826.100866296418;3852.691784657277;51363.743181283855;55955.440445595836;56192.15711764327;56481.43518564762;57803;47836;50527.7473612637;51060;51215.743921280155;51894.48105518897;44229;44540;44603.99999999935;45178.32232516515;45319.32021019687;8277.95861020691;8732.301415886586;9265.166135047879;9299.256059515088;9379.953100234456;34503.65496345004;34525.65474345224;34830;35041.42436071091;35661.28677426489;40380.1923961525;44286.77856610825;44373.55626443694;45331;45364.773176135226;7771.300582947561;7772.57250851186;7812.726554570563;7944.364450844034;8148.918510814816;11875.228110172811;12005;12112.818307725214;12138.635840924786;12702.30137342455;11751.294922304689;11781.941090294493;11942.223755455867;11954.149289513634;12050.096242782001;11075.335479871233;11133.332000080021;11205.215634905479;11772.426925734982;12280.75438491243;10787.730306742395;10793.946030269799;11040.779184416428;11073.723156921142;12037.879621203676;9653;9946.303758736818;10099.192064634959;10121.392716437038;10354.896451035393;9542.809143816947;10262.743431414274;10307.330023548446;10315.535800889129;10424.166066714797 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681088529__endTimestamp 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:38:08 INFO - 2015-11-16 05:38:08,542 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,543 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5457.18 Median:5703.71 stddev:614.71 (10.8%) stddev-sans-first:590.34 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: Values: 3191.7 3227.7 3251.1 3273.5 3275.9 5280.3 5378.7 5461.9 5465.6 5476.9 5352.7 5357.0 5392.1 5446.4 5464.8 4688.6 4930.9 5176.0 5179.2 5181.7 4907.0 5095.8 5120.4 5124.1 5189.8 4869.0 4965.9 4993.2 4995.1 5032.4 4935.3 4939.3 4941.2 4966.8 4993.8 4827.1 4914.0 4914.7 4921.1 4986.1 5218.6 5249.1 5258.3 5272.4 5357.1 5863.4 5872.4 5875.3 5876.9 5877.1 5734.7 5844.4 5847.9 5865.8 5880.1 5397.5 5446.4 5462.0 5478.3 5479.9 5939.5 5950.9 5970.7 6006.8 6011.2 5814.0 5825.8 5830.8 5833.2 5839.6 5706.4 5808.4 5809.8 5872.7 5905.6 5785.4 5901.4 5916.9 5926.1 5939.5 5851.3 5876.2 5884.9 5914.5 5917.1 4371.5 4415.0 4487.5 4505.5 4547.7 4038.4 4041.8 4051.2 4080.1 4086.8 5550.3 5655.9 5663.2 5668.8 5674.1 5800.2 5925.5 5928.3 5929.8 5930.1 5635.8 5640.6 5644.9 5648.9 5675.7 5096.3 5106.4 5108.8 5126.5 5148.5 5962.4 6046.6 6047.6 6052.2 6117.8 5814.6 5888.0 5900.7 5932.6 5989.9 6029.7 6117.3 6119.8 6138.4 6144.9 5682.1 5744.6 5779.9 5842.3 5842.9 5878.8 5884.6 5893.0 5911.7 5922.6 5703.7 5704.0 5712.7 5748.8 5756.1 5644.3 5652.9 5724.0 5784.9 5793.0 5725.4 5729.3 5741.5 5768.4 5770.8 5820.7 5858.9 5869.9 5902.6 5908.9 5446.3 5529.5 5593.3 5684.8 5709.9 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48445.12 Median:36636.67 stddev:87741.71 (239.5%) stddev-sans-first:87914.26 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: Values: 582.1 592.6 593.1 595.9 606.4 35138.8 36067.3 36300.6 36428.6 36434.0 41646.2 42263.8 42498.4 42526.4 42597.0 8864.7 8994.1 9015.2 9031.7 9033.6 8745.6 8783.7 8798.7 8821.3 8859.7 8778.6 8792.8 8829.3 8834.7 8878.2 8727.2 8842.3 8847.9 8855.4 8872.8 8712.9 8854.8 8861.5 8877.0 8878.9 38928.2 39568.0 39574.6 39610.6 39624.4 3192.8 3204.9 3238.6 3243.4 3347.5 29291.0 29645.5 29842.7 30067.7 30345.8 3353.7 3357.5 3376.0 3378.3 3391.2 275912.0 276220.6 276574.0 276788.0 277268.0 41305.4 55727.7 56056.7 56164.7 56194.4 40822.8 40827.6 40913.4 40927.0 41004.4 13182.1 13283.1 13315.3 13341.2 13401.6 10424.6 10443.8 10475.8 10490.0 10536.7 13881.8 13901.2 14039.5 14215.2 14276.9 5786.7 5838.7 5871.9 5913.9 5986.7 943.0 969.5 1022.8 1070.7 1141.9 27748.9 28469.1 28494.7 32079.5 32355.8 1030.9 1035.7 1039.2 1042.8 1051.7 13064.8 13110.9 13144.9 13185.6 13224.8 403050.0 408792.0 409458.0 412737.0 414578.0 51745.5 52129.2 52180.7 52224.2 52492.2 1339.7 1341.8 1348.9 1351.3 1354.0 24333.9 25081.6 25242.7 25324.5 25532.6 41998.2 42794.6 42830.8 42841.4 42873.0 296282.0 296968.0 298720.0 299023.0 299640.0 31707.0 45109.1 45258.5 46282.5 46368.0 42783.4 42906.1 43069.6 43591.0 44046.6 36131.8 36949.3 37324.0 37385.3 37743.0 36262.3 36839.3 36862.4 37078.4 37250.1 34932.5 35394.8 35693.3 35703.5 36013.8 30777.4 33438.7 33806.8 33832.7 33956.0 26590.5 27727.0 27730.7 27768.3 27811.2 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26021.89 Median:4361.18 stddev:84632.07 (1940.6%) stddev-sans-first:84847.50 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: Values: 329.7 344.0 346.0 346.8 348.2 12651.7 13057.1 13731.2 15567.2 16361.6 11327.9 11442.5 11547.2 11834.9 11854.9 4561.2 4638.0 4664.6 4693.0 4695.7 4347.5 4350.9 4357.9 4364.4 4390.7 4520.0 4585.0 4590.8 4734.9 4880.0 4810.5 4822.6 4825.6 4856.2 4865.9 4077.4 4322.2 4322.5 4331.2 4332.9 13196.3 13259.8 13492.7 13888.5 13953.6 1985.3 2038.9 2047.1 2082.8 2084.5 10184.9 10198.7 10201.5 10329.2 10425.1 1663.5 1682.7 1690.8 1718.3 1723.5 57274.0 58516.1 59717.7 59794.4 59824.4 6899.3 6984.2 7059.5 7125.7 7183.8 8517.2 8547.8 8578.2 8589.6 8599.4 5471.8 5487.7 5489.0 5518.1 5521.8 5512.0 5551.9 5554.5 5601.8 5607.6 3283.3 3293.9 3301.5 3328.7 3338.1 1165.4 1165.7 1170.5 1186.9 1220.2 450.7 484.6 510.3 513.2 520.3 11256.7 11428.3 11530.8 11646.4 11757.1 500.7 508.8 510.7 516.2 521.7 6369.7 6492.3 6504.1 6589.6 6608.5 507762.0 513844.0 519121.0 520084.0 520597.0 72819.3 73080.0 73912.3 74989.6 76697.0 559.2 559.5 560.7 560.8 562.7 10641.4 10910.6 11082.1 11179.4 11181.8 32716.7 32753.0 32786.0 33385.5 33485.3 45656.0 46341.3 46451.0 47470.0 47682.8 6923.5 6972.9 6979.1 6986.1 7034.1 12385.3 12711.3 12763.6 12794.9 12897.2 8767.4 8882.6 10373.6 10736.9 10783.7 10068.7 10642.5 10665.7 10919.5 11215.9 10590.8 10864.3 10934.1 11011.2 11334.9 6868.5 6948.7 7006.7 7014.1 7015.5 10565.8 10772.5 10876.4 11027.1 11089.6 05:38:08 INFO - 2015-11-16 05:38:08,544 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,545 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5145.31 Median:6327.12 stddev:2627.17 (41.5%) stddev-sans-first:2619.80 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: Values: 1442.4 1507.3 1590.1 1618.0 1736.4 6728.0 6871.8 7222.7 7412.6 7430.9 7071.0 7111.0 7249.9 7250.0 7256.7 2179.7 2213.4 2218.2 2219.2 2227.3 2209.4 2242.7 2243.1 2246.3 2258.1 2206.7 2231.0 2237.7 2256.3 2275.7 2109.3 2125.4 2147.1 2148.1 2151.6 2213.1 2214.0 2224.1 2232.0 2238.8 7385.3 7397.9 7438.0 7460.6 7479.9 4388.9 4462.8 4467.9 4479.8 4483.9 2857.7 2945.6 2953.8 2954.1 2967.1 918.2 933.5 940.3 960.9 978.2 9823.3 9883.3 9907.4 9910.5 9965.2 4186.2 4193.4 4224.5 4233.5 4241.6 8507.0 8510.0 8518.2 8529.4 8574.3 4469.4 4515.0 4515.8 4524.8 4525.5 3607.1 3689.3 3996.6 4078.0 4081.9 3566.8 3580.2 3654.8 3661.3 3673.4 1166.6 1169.5 1174.6 1178.4 1200.1 1082.9 1094.6 1102.6 1236.8 1326.3 6910.3 6948.4 6974.8 6978.5 7008.5 469.7 473.8 474.4 476.0 476.6 5504.8 5528.2 5550.8 5552.9 5564.1 8533.6 8612.7 8617.2 8710.9 8738.0 8379.7 8446.2 8551.8 8565.9 8574.7 6745.3 6787.3 6788.3 6845.1 6849.0 6223.9 6332.5 6382.4 6391.4 6402.2 7483.2 7583.8 7593.2 7610.2 7752.7 7860.9 7869.4 7886.9 7930.3 7987.2 6341.3 6432.9 6658.1 6705.7 6754.7 7269.7 7316.2 7317.1 7349.0 7358.8 6781.4 6801.4 6813.5 7034.7 7045.2 6734.2 6791.5 6794.0 6913.9 6952.8 6651.0 6688.7 6704.5 6745.8 6765.3 6265.7 6274.4 6282.7 6309.7 6321.7 6011.0 6082.5 6082.5 6082.9 6092.4 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5649.02 Median:6468.95 stddev:1746.08 (27.0%) stddev-sans-first:1704.24 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: Values: 302.4 309.9 310.8 316.8 317.3 6222.1 6343.4 6368.4 6408.8 6421.9 6279.8 6307.1 6309.9 6328.5 6336.6 4707.1 4759.7 4791.5 4800.0 4808.6 4787.4 4803.3 4817.2 4852.6 4866.8 4784.0 4791.5 4797.0 4798.6 4811.6 4778.2 4796.6 4801.4 4815.0 4818.5 4099.1 4175.8 4190.3 4194.3 4205.5 5956.8 5999.3 6025.4 6026.1 6027.8 5552.2 5593.7 5602.8 5607.0 5614.3 6617.2 6706.0 6727.6 6732.4 6746.5 4550.4 4589.7 4598.3 4600.7 4602.4 6926.0 6940.9 6951.9 6986.0 6986.6 4678.0 4679.1 4694.0 4697.7 4698.0 4652.5 4737.5 4740.5 4751.6 4758.2 5523.5 5538.5 5540.6 5542.5 5544.1 6803.6 6812.1 6816.8 6821.7 6828.0 1641.8 1675.7 1677.4 1680.4 1681.2 1098.3 1104.9 1110.5 1121.6 1157.3 6422.0 6515.9 6517.2 6531.6 6536.5 6994.7 7026.8 7060.8 7065.6 7067.5 6550.6 6606.0 6607.3 6614.6 6624.9 3750.8 3789.3 3795.6 3821.3 3831.3 7362.4 7370.1 7375.7 7400.0 7422.2 7207.5 7235.6 7244.7 7245.9 7285.8 7145.2 7309.0 7333.4 7356.0 7357.3 7046.0 7048.8 7049.2 7062.5 7078.9 6962.3 6983.9 6989.5 7016.2 7031.4 7244.4 7380.3 7382.9 7400.9 7407.5 4523.3 4591.1 4609.4 4615.9 4618.8 6999.1 6999.2 7069.1 7071.8 7081.8 6684.4 6798.3 6815.0 6833.0 6841.7 6791.6 6793.7 6810.4 6819.5 6844.8 6566.6 6634.9 6681.5 6681.7 6695.9 6679.4 6827.2 6832.9 6836.5 6840.8 6544.5 6609.2 6610.8 6627.2 6666.4 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: 05:38:08 INFO - 2015-11-16 05:38:08,546 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13479.09 Median:471.91 stddev:15534.67 (3291.9%) stddev-sans-first:15548.76 05:38:08 INFO - 2015-11-16 05:38:08,547 DEBUG : BROWSER_OUTPUT: Values: 732.9 740.8 754.6 849.8 862.0 13503.1 13669.0 13703.5 13755.0 13755.2 13009.6 13140.5 13163.9 14068.2 14136.0 800.0 806.7 807.0 808.2 808.9 814.1 814.6 815.2 816.8 819.8 848.4 849.0 852.5 853.0 855.8 843.9 846.4 849.1 849.1 857.8 619.1 622.2 623.8 623.9 627.9 12764.7 12782.6 12796.9 12903.6 12920.7 10912.8 11025.7 11083.2 11089.6 11202.4 9675.3 9710.3 9710.4 9843.5 9852.0 3441.2 3547.1 3567.9 3678.7 3764.2 42247.2 43442.3 47677.0 47707.3 49062.3 9159.9 9334.2 9381.9 9444.6 9452.4 17503.7 18037.1 18039.2 18100.5 18153.0 7801.8 7831.6 7841.4 7869.2 7961.1 4231.2 4281.9 4349.5 4365.9 4390.8 2960.7 2962.6 2968.5 2974.6 2980.1 469.4 470.4 473.4 474.3 480.1 569.9 642.0 665.1 673.5 681.2 8374.0 8512.4 8625.2 8632.2 8690.1 525.1 539.6 624.8 637.4 671.6 3768.0 3769.8 3777.6 3826.1 3852.7 51363.7 55955.4 56192.2 56481.4 57803.0 47836.0 50527.7 51060.0 51215.7 51894.5 44229.0 44540.0 44604.0 45178.3 45319.3 8278.0 8732.3 9265.2 9299.3 9380.0 34503.7 34525.7 34830.0 35041.4 35661.3 40380.2 44286.8 44373.6 45331.0 45364.8 7771.3 7772.6 7812.7 7944.4 8148.9 11875.2 12005.0 12112.8 12138.6 12702.3 11751.3 11781.9 11942.2 11954.1 12050.1 11075.3 11133.3 11205.2 11772.4 12280.8 10787.7 10793.9 11040.8 11073.7 12037.9 9653.0 9946.3 10099.2 10121.4 10354.9 9542.8 10262.7 10307.3 10315.5 10424.2 05:38:08 INFO - 2015-11-16 05:38:08,547 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:38:08 INFO - 2015-11-16 05:38:08,547 DEBUG : BROWSER_OUTPUT: 05:38:09 INFO - 2015-11-16 05:38:09,209 INFO : Browser exited with error code: 0 05:38:09 INFO - 2015-11-16 05:38:09,230 INFO : Completed test dromaeo_css (00:18:30) 05:38:09 INFO - 2015-11-16 05:38:09,230 INFO : Starting test kraken 05:38:09 INFO - 2015-11-16 05:38:09,230 DEBUG : operating with platform_type : linux_ 05:38:09 INFO - 2015-11-16 05:38:09,231 INFO : Initialising browser for kraken test... 05:38:09 INFO - 2015-11-16 05:38:09,237 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LtGSz/profile http://localhost:34899/getInfo.html 05:38:13 INFO - 2015-11-16 05:38:13,626 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:38:13 INFO - 2015-11-16 05:38:13,626 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:38:13 INFO - 2015-11-16 05:38:13,627 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:38:13 INFO - 2015-11-16 05:38:13,627 DEBUG : BROWSER_OUTPUT: __metrics 05:38:14 INFO - 2015-11-16 05:38:14,561 INFO : Browser initialized. 05:38:14 INFO - 2015-11-16 05:38:14,562 INFO : Running cycle 1/1 for kraken test... 05:38:14 INFO - 2015-11-16 05:38:14,562 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LtGSz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:26 INFO - 2015-11-16 05:38:26,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 05:38:26 INFO - 2015-11-16 05:38:26,390 DEBUG : BROWSER_OUTPUT: 05:38:28 INFO - 2015-11-16 05:38:28,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:29 INFO - 2015-11-16 05:38:29,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 05:38:29 INFO - 2015-11-16 05:38:29,467 DEBUG : BROWSER_OUTPUT: 05:38:32 INFO - 2015-11-16 05:38:32,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-dft) 05:38:32 INFO - 2015-11-16 05:38:32,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 05:38:32 INFO - 2015-11-16 05:38:32,728 DEBUG : BROWSER_OUTPUT: 05:38:35 INFO - 2015-11-16 05:38:35,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-fft) 05:38:36 INFO - 2015-11-16 05:38:36,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 136945664 05:38:36 INFO - 2015-11-16 05:38:36,140 DEBUG : BROWSER_OUTPUT: 05:38:38 INFO - 2015-11-16 05:38:38,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34899/tests/kraken/driver.html?testName=audio-oscillator) 05:38:38 INFO - 2015-11-16 05:38:38,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 136237056 05:38:38 INFO - 2015-11-16 05:38:38,752 DEBUG : BROWSER_OUTPUT: 05:38:40 INFO - 2015-11-16 05:38:40,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:41 INFO - 2015-11-16 05:38:41,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 136986624 05:38:41 INFO - 2015-11-16 05:38:41,536 DEBUG : BROWSER_OUTPUT: 05:38:44 INFO - 2015-11-16 05:38:44,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:45 INFO - 2015-11-16 05:38:45,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 138653696 05:38:45 INFO - 2015-11-16 05:38:45,116 DEBUG : BROWSER_OUTPUT: 05:38:48 INFO - 2015-11-16 05:38:48,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34899/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:49 INFO - 2015-11-16 05:38:49,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 136818688 05:38:49 INFO - 2015-11-16 05:38:49,186 DEBUG : BROWSER_OUTPUT: 05:38:52 INFO - 2015-11-16 05:38:52,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34899/tests/kraken/driver.html?testName=json-parse-financial) 05:38:52 INFO - 2015-11-16 05:38:52,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 136302592 05:38:52 INFO - 2015-11-16 05:38:52,688 DEBUG : BROWSER_OUTPUT: 05:38:54 INFO - 2015-11-16 05:38:54,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:54 INFO - 2015-11-16 05:38:54,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 137445376 05:38:54 INFO - 2015-11-16 05:38:54,859 DEBUG : BROWSER_OUTPUT: 05:38:56 INFO - 2015-11-16 05:38:56,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:57 INFO - 2015-11-16 05:38:57,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 138514432 05:38:57 INFO - 2015-11-16 05:38:57,284 DEBUG : BROWSER_OUTPUT: 05:38:59 INFO - 2015-11-16 05:38:59,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:59 INFO - 2015-11-16 05:38:59,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 05:38:59 INFO - 2015-11-16 05:38:59,978 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-16 05:39:02,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:03 INFO - 2015-11-16 05:39:03,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 137187328 05:39:03 INFO - 2015-11-16 05:39:03,022 DEBUG : BROWSER_OUTPUT: 05:39:05 INFO - 2015-11-16 05:39:05,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:06 INFO - 2015-11-16 05:39:06,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 138018816 05:39:06 INFO - 2015-11-16 05:39:06,204 DEBUG : BROWSER_OUTPUT: 05:39:07 INFO - 2015-11-16 05:39:07,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34899/tests/kraken/driver.html?testName=ai-astar) 05:39:08 INFO - 2015-11-16 05:39:08,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 05:39:08 INFO - 2015-11-16 05:39:08,148 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,149 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:08 INFO - 2015-11-16 05:39:08,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:08 INFO - 2015-11-16 05:39:08,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:08 INFO - 2015-11-16 05:39:08,150 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:08 INFO - 2015-11-16 05:39:08,150 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;104;111;110;112;123;111;110;111;111 05:39:08 INFO - 2015-11-16 05:39:08,150 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;126;157;158;129;154;157;135;163;130 05:39:08 INFO - 2015-11-16 05:39:08,151 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;164;162;162;165;169;162 05:39:08 INFO - 2015-11-16 05:39:08,151 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;73;73;72;143;73;72;72;72 05:39:08 INFO - 2015-11-16 05:39:08,151 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;135;89;91;92;138;92;90;146 05:39:08 INFO - 2015-11-16 05:39:08,152 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;109;109;109;110;110;109 05:39:08 INFO - 2015-11-16 05:39:08,152 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;149;147;146;147;147;147 05:39:08 INFO - 2015-11-16 05:39:08,152 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;99;96;97;97;96 05:39:08 INFO - 2015-11-16 05:39:08,152 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;63;66;65;63;62;63;63;63 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;70;68;70;69;69 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;95;94;86;84;87;85;84;92 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;117;121;116;127;128;130;123;121;119 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;151;164;163;150;148;159;151;150;138 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;68;66;71;68;67;66;67 05:39:08 INFO - 2015-11-16 05:39:08,153 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:08 INFO - 2015-11-16 05:39:08,154 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:39:08 INFO - 2015-11-16 05:39:08,154 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,701 05:39:08 INFO - 2015-11-16 05:39:08,154 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:39:08 INFO - 2015-11-16 05:39:08,154 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681148148__endTimestamp 05:39:08 INFO - 2015-11-16 05:39:08,154 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,155 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:08 INFO - 2015-11-16 05:39:08,155 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:39:08 INFO - 2015-11-16 05:39:08,155 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.67 (4.2%) stddev-sans-first:4.93 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: Values: 113.0 104.0 111.0 110.0 112.0 123.0 111.0 110.0 111.0 111.0 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:155.50 stddev:14.22 (9.1%) stddev-sans-first:15.01 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: Values: 150.0 126.0 157.0 158.0 129.0 154.0 157.0 135.0 163.0 130.0 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,156 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.20 Median:162.00 stddev:2.30 (1.4%) stddev-sans-first:2.40 05:39:08 INFO - 2015-11-16 05:39:08,157 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 164.0 162.0 162.0 165.0 169.0 162.0 05:39:08 INFO - 2015-11-16 05:39:08,157 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,157 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:72.50 stddev:22.29 (30.7%) stddev-sans-first:23.47 05:39:08 INFO - 2015-11-16 05:39:08,157 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 73.0 72.0 143.0 73.0 72.0 72.0 72.0 05:39:08 INFO - 2015-11-16 05:39:08,158 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,158 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:90.50 stddev:23.82 (26.3%) stddev-sans-first:24.60 05:39:08 INFO - 2015-11-16 05:39:08,158 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 135.0 89.0 91.0 92.0 138.0 92.0 90.0 146.0 05:39:08 INFO - 2015-11-16 05:39:08,158 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 149.0 147.0 146.0 147.0 147.0 147.0 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,159 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:39:08 INFO - 2015-11-16 05:39:08,160 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 99.0 96.0 97.0 97.0 96.0 05:39:08 INFO - 2015-11-16 05:39:08,160 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,160 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.32 05:39:08 INFO - 2015-11-16 05:39:08,160 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 66.0 65.0 63.0 62.0 63.0 63.0 63.0 05:39:08 INFO - 2015-11-16 05:39:08,161 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,161 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:39:08 INFO - 2015-11-16 05:39:08,161 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 70.0 68.0 70.0 69.0 69.0 05:39:08 INFO - 2015-11-16 05:39:08,161 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,162 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:86.50 stddev:4.35 (5.0%) stddev-sans-first:4.42 05:39:08 INFO - 2015-11-16 05:39:08,162 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 95.0 94.0 86.0 84.0 87.0 85.0 84.0 92.0 05:39:08 INFO - 2015-11-16 05:39:08,162 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,162 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.00 stddev:4.98 (4.1%) stddev-sans-first:4.95 05:39:08 INFO - 2015-11-16 05:39:08,162 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 121.0 116.0 127.0 128.0 130.0 123.0 121.0 119.0 05:39:08 INFO - 2015-11-16 05:39:08,163 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,163 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:151.00 stddev:8.27 (5.5%) stddev-sans-first:8.15 05:39:08 INFO - 2015-11-16 05:39:08,163 DEBUG : BROWSER_OUTPUT: Values: 143.0 151.0 164.0 163.0 150.0 148.0 159.0 151.0 150.0 138.0 05:39:08 INFO - 2015-11-16 05:39:08,163 DEBUG : BROWSER_OUTPUT: 05:39:08 INFO - 2015-11-16 05:39:08,164 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 05:39:08 INFO - 2015-11-16 05:39:08,164 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 68.0 66.0 71.0 68.0 67.0 66.0 67.0 05:39:08 INFO - 2015-11-16 05:39:08,164 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:08 INFO - 2015-11-16 05:39:08,164 DEBUG : BROWSER_OUTPUT: 05:39:09 INFO - 2015-11-16 05:39:09,157 INFO : Browser exited with error code: 0 05:39:09 INFO - 2015-11-16 05:39:09,213 INFO : Completed test kraken (00:00:59) 05:39:09 INFO - 2015-11-16 05:39:09,213 INFO : Starting test v8_7 05:39:09 INFO - 2015-11-16 05:39:09,213 DEBUG : operating with platform_type : linux_ 05:39:09 INFO - 2015-11-16 05:39:09,213 INFO : Initialising browser for v8_7 test... 05:39:09 INFO - 2015-11-16 05:39:09,220 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNXJIsk/profile http://localhost:34899/getInfo.html 05:39:13 INFO - 2015-11-16 05:39:13,539 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:39:13 INFO - 2015-11-16 05:39:13,539 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:39:13 INFO - 2015-11-16 05:39:13,539 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:39:13 INFO - 2015-11-16 05:39:13,539 DEBUG : BROWSER_OUTPUT: __metrics 05:39:14 INFO - 2015-11-16 05:39:14,529 INFO : Browser initialized. 05:39:14 INFO - 2015-11-16 05:39:14,530 INFO : Running cycle 1/1 for v8_7 test... 05:39:14 INFO - 2015-11-16 05:39:14,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNXJIsk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:39:26 INFO - 2015-11-16 05:39:26,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 05:39:26 INFO - 2015-11-16 05:39:26,378 DEBUG : BROWSER_OUTPUT: 05:39:47 INFO - 2015-11-16 05:39:47,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34899/tests/v8_7/run.html (next: http://localhost:34899/tests/v8_7/run.html) 05:39:48 INFO - 2015-11-16 05:39:48,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 138514432 05:39:48 INFO - 2015-11-16 05:39:48,063 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,063 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:48 INFO - 2015-11-16 05:39:48,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:48 INFO - 2015-11-16 05:39:48,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |0;Richards;164.06890894175552 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.12475859405177 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.9002849002849 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 05:39:48 INFO - 2015-11-16 05:39:48,064 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1058.2010582010582 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: |5;Earley;716.8458781362007 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: |8;Splay;556.8432671081678 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681188062__endTimestamp 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:39:48 INFO - 2015-11-16 05:39:48,065 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.07 Median:164.07 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: Values: 164.1 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.12 Median:193.12 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: Values: 193.1 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: Values: 284.9 05:39:48 INFO - 2015-11-16 05:39:48,066 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,067 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: Values: 5050.5 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: Values: 1058.2 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,068 DEBUG : BROWSER_OUTPUT: Values: 716.8 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: Values: 12280.5 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: Values: 25743.6 05:39:48 INFO - 2015-11-16 05:39:48,069 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:556.84 Median:556.84 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: Values: 556.8 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: Values: 4822.1 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:48 INFO - 2015-11-16 05:39:48,070 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-11-16 05:39:48,993 INFO : Browser exited with error code: 0 05:39:49 INFO - 2015-11-16 05:39:49,005 INFO : Completed test v8_7 (00:00:39) 05:39:49 INFO - 2015-11-16 05:39:49,087 INFO : Completed test suite (00:20:09) 05:39:49 INFO - 2015-11-16 05:39:49,087 DEBUG : Working with test: dromaeo_css 05:39:49 INFO - 2015-11-16 05:39:49,087 DEBUG : Generating results file: dromaeo_css 05:39:49 INFO - 2015-11-16 05:39:49,088 DEBUG : Working with test: kraken 05:39:49 INFO - 2015-11-16 05:39:49,088 DEBUG : Generating results file: kraken 05:39:49 INFO - 2015-11-16 05:39:49,089 INFO : javascript benchmark 05:39:49 INFO - 2015-11-16 05:39:49,089 DEBUG : Working with test: v8_7 05:39:49 INFO - 2015-11-16 05:39:49,089 DEBUG : Generating results file: v8_7 05:39:49 INFO - 2015-11-16 05:39:49,089 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:49 INFO - 2015-11-16 05:39:49,147 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:39:49 INFO - 2015-11-16 05:39:49,147 DEBUG : process_Request line: dromaeo_css 6657.59 graph.html#tests=[[72,1,43]] 05:39:49 INFO - 2015-11-16 05:39:49,147 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:49 INFO - 2015-11-16 05:39:49,185 DEBUG : process_Request line: kraken 1519.90 graph.html#tests=[[232,1,43]] 05:39:49 INFO - 2015-11-16 05:39:49,185 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:49 INFO - 2015-11-16 05:39:49,219 DEBUG : process_Request line: v8_7 21512.04 graph.html#tests=[[230,1,43]] 05:39:49 INFO - 2015-11-16 05:39:49,220 INFO : javascript benchmark 05:39:49 INFO - 2015-11-16 05:39:49,224 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [329.698326031681, 343.9931201375971, 346.02420180767814, 346.7884590399856, 348.1557223732448, 12651.683707907307, 13057.086003979724, 13731.244781537023, 15567.221638918065, 16361.590960226, 11327.943360283187, 11442.485088171052, 11547.191696581243, 11834.881651183485, 11854.881451185485, 4561.178987782189, 4638.0, 4664.603508701764, 4693.037927224927, 4695.741734204617, 4347.543507931669, 4350.934735978963, 4357.934630980538, 4364.432623758907, 4390.692651514395, 4519.954800452003, 4585.014221942299, 4590.839320623779, 4734.90530189396, 4880.0, 4810.518948105161, 4822.638302127354, 4825.589824864891, 4856.17445034345, 4865.8783530411665, 4077.3680079587416, 4322.157179350028, 4322.524522302544, 4331.242032644306, 4332.870013899588, 13196.340182990813, 13259.801102983463, 13492.730145397038, 13888.513902013381, 13953.581392558139, 1985.3349128042123, 2038.8878611676353, 2047.129969762845, 2082.8437867160023, 2084.5050793634987, 10184.898151018544, 10198.745031374201, 10201.489925503694, 10329.225308101923, 10425.113865321457, 1663.4760050584148, 1682.7055265328518, 1690.7717458143115, 1718.321263101068, 1723.5087999920088, 57274.0, 58516.122258166586, 59717.7014114931, 59794.40205597932, 59824.40175598232, 6899.344562266577, 6984.2317345092, 7059.505834591632, 7125.679344429514, 7183.820404489929, 8517.190866867637, 8547.82904341922, 8578.18507241811, 8589.570521473901, 8599.441036332619, 5471.781128754885, 5487.725613719298, 5489.0, 5518.117101263859, 5521.834344969658, 5512.035393806148, 5551.8889622207325, 5554.472325129106, 5601.831945041574, 5607.551395888319, 3283.326917981856, 3293.92947292131, 3301.5047742838765, 3328.7004169624365, 3338.115399419156, 1165.44641295384, 1165.7143999720122, 1170.4908364861312, 1186.8813118688236, 1220.17638094286, 450.662003497377, 484.60988903932673, 510.25757522804975, 513.2019709351919, 520.2508387921381, 11256.718582035515, 11428.314301141958, 11530.76938461226, 11646.36950826885, 11757.059435245159, 500.68707058088694, 508.8397154896196, 510.6859281541899, 516.2256615077384, 521.6583138044587, 6369.681515924185, 6492.253390860017, 6504.089427480157, 6589.6375699336995, 6608.537402381883, 507762.0, 513844.0, 519121.0, 520084.0, 520597.0, 72819.27180728124, 73080.0, 73912.26087739161, 74989.62505187548, 76697.0, 559.2394343692575, 559.5439716630933, 560.742058653016, 560.8429639700972, 562.6680258647336, 10641.361518308926, 10910.61812836547, 11082.113430925669, 11179.385133817717, 11181.776364472502, 32716.672833272314, 32753.0, 32786.0, 33385.499217512246, 33485.33029339448, 45656.0, 46341.304880427495, 46451.0, 47470.0, 47682.761586193235, 6923.5499692519825, 6972.860542789217, 6979.057827193467, 6986.091808064919, 7034.050403195503, 12385.318807465315, 12711.300878451773, 12763.553275635679, 12794.936025320187, 12897.161684490478, 8767.386282960386, 8882.62002900726, 10373.58505659765, 10736.946315268373, 10783.676489705322, 10068.69793906184, 10642.521086550969, 10665.680029599125, 10919.454027298762, 11215.943920280346, 10590.841137382791, 10864.293820901616, 10934.125269978542, 11011.174161937726, 11334.886651133713, 6868.523267497512, 6948.687309071205, 7006.6846991886505, 7014.0531028310525, 7015.473839462163, 10565.788684226427, 10772.461376930965, 10876.401797901191, 11027.117830573696, 11089.5564177432], "dojo.html": [3191.6648751881053, 3227.661095584965, 3251.1221970068095, 3273.52533882587, 3275.934481310374, 5280.260763493105, 5378.704171270583, 5461.918071228934, 5465.590080743945, 5476.931998260341, 5352.732363381835, 5357.035733567956, 5392.056390131721, 5446.400895901447, 5464.781408743655, 4688.624910007208, 4930.852074437764, 5175.974120129413, 5179.223116532513, 5181.715005674687, 4907.043126590316, 5095.770690318926, 5120.411152717448, 5124.052050370675, 5189.8183563575285, 4868.975655121737, 4965.925511117336, 4993.151164302078, 4995.075910956485, 5032.446430892599, 4935.333729946483, 4939.333190019373, 4941.209406494943, 4966.776495057731, 4993.825216117419, 4827.08285425768, 4914.0, 4914.680545764514, 4921.089598424303, 4986.10250154972, 5218.608604354688, 5249.1338929076655, 5258.290130832327, 5272.420033796279, 5357.08929481989, 5863.442972917609, 5872.442117998826, 5875.2949646042325, 5876.911846322266, 5877.118432235156, 5734.684592347419, 5844.415558444164, 5847.883042339172, 5865.794697185621, 5880.147378630118, 5397.541208997279, 5446.373667028263, 5462.0441422751255, 5478.287822583078, 5479.945200547983, 5939.495142912814, 5950.851228719317, 5970.731317090741, 6006.789762358297, 6011.218541589566, 5813.970930145322, 5825.76696932118, 5830.82507524775, 5833.212516310244, 5839.620424672383, 5706.3722990471015, 5808.448197421239, 5809.82570522885, 5872.7357268923, 5905.586608937333, 5785.392533783976, 5901.439363260483, 5916.940830591725, 5926.051831706906, 5939.4951429129005, 5851.297844258631, 5876.236089308362, 5884.882302353929, 5914.526837852962, 5917.082852157922, 4371.497277813029, 4414.977925110418, 4487.461504619467, 4505.5269196734525, 4547.727136371828, 4038.414429907647, 4041.7574945503366, 4051.1897620476025, 4080.10237747695, 4086.775227362464, 5550.333959924754, 5655.886882262332, 5663.178839068312, 5668.801591944345, 5674.120511320752, 5800.24596802413, 5925.466707996301, 5928.318243401977, 5929.762809487658, 5930.110483427434, 5635.830925072254, 5640.633358831663, 5644.858878527987, 5648.8870222595315, 5675.716214189274, 5096.261042148942, 5106.412762532356, 5108.821191258363, 5126.461721519261, 5148.4851514848215, 5962.403759624003, 6046.637201767908, 6047.576669633171, 6052.152698622196, 6117.816465506042, 5814.622049566765, 5887.970560147171, 5900.734466949083, 5932.614380065282, 5989.850253743692, 6029.728662210299, 6117.3270940197435, 6119.785807496716, 6138.355472675305, 6144.907826382519, 5682.119271512922, 5744.626599271034, 5779.884402311846, 5842.298924129132, 5842.941570584409, 5878.794242201502, 5884.558658100746, 5893.0, 5911.674857882857, 5922.644641321534, 5703.714814259188, 5703.971480142573, 5712.685802280915, 5748.827535173951, 5756.107803290497, 5644.322681278109, 5652.943470565242, 5724.026915424472, 5784.929787989067, 5792.9710351447975, 5725.370209276893, 5729.255196824386, 5741.4832665058675, 5768.423157684198, 5770.769169233184, 5820.650760954187, 5858.853528661817, 5869.911951320819, 5902.6458412495385, 5908.852278692895, 5446.264754258283, 5529.529989950899, 5593.328800543798, 5684.8294551163535, 5709.942900571107], "mootools.html": [1442.4014034175816, 1507.3066389460844, 1590.1492701404736, 1617.975730364044, 1736.3835838277412, 6728.0, 6871.759488417906, 7222.711091556338, 7412.592307423083, 7430.851382972337, 7070.964645176779, 7110.964445177767, 7249.891251631229, 7249.963750181255, 7256.709731610729, 2179.6621523663857, 2213.380253529014, 2218.223621732397, 2219.234364144376, 2227.307246492669, 2209.3924170852983, 2242.6636004599277, 2243.1139699818564, 2246.29241788836, 2258.096761295487, 2206.680031395447, 2231.040652519424, 2237.742659594143, 2256.26671331817, 2275.7155355580553, 2109.2512158183777, 2125.3517677108475, 2147.1304121830603, 2148.0655914677163, 2151.580441813847, 2213.1147540983575, 2213.966790498144, 2224.088123869206, 2232.0179121186625, 2238.7649296823924, 7385.335319821242, 7397.889031664529, 7437.99587055746, 7460.552366858006, 7479.887801682979, 4388.868333949987, 4462.843800467001, 4467.932981005288, 4479.798409071567, 4483.910321793546, 2857.6999415061327, 2945.617069780936, 2953.8080024798533, 2954.1285320830407, 2967.109867039901, 918.1736437206567, 933.4912472702393, 940.2618944128894, 960.8894977077656, 978.1636700620937, 9823.312368134304, 9883.308168428213, 9907.356021858555, 9910.454924979123, 9965.20278377728, 4186.204621121977, 4193.433886425354, 4224.5353011168745, 4233.534311225824, 4241.575842415734, 8506.957465212634, 8510.0, 8518.190771876662, 8529.360297977677, 8574.27118694918, 4469.41897553316, 4515.029268707178, 4515.796789144496, 4524.773761311922, 4525.52481989393, 3607.1162565171703, 3689.2990331836863, 3996.6003399659803, 4078.0, 4081.89795255121, 3566.7859928404378, 3580.230250496156, 3654.7624404413627, 3661.2860492204295, 3673.393890008172, 1166.6150170443734, 1169.4562028656715, 1174.5712814822527, 1178.3695722788268, 1200.1059210887945, 1082.929609575375, 1094.5676457799284, 1102.6030628973563, 1236.8330275412704, 1326.323574976769, 6910.2744211858035, 6948.44412447003, 6974.825629359205, 6978.546394484342, 7008.5094043416475, 469.67123013890415, 473.76785375165923, 474.41172945547964, 475.9714417134983, 476.62822998060875, 5504.834854954358, 5528.170774383794, 5550.750216240279, 5552.888942221133, 5564.10974244119, 8533.573321333908, 8612.741617751477, 8617.224449799549, 8710.912890871137, 8737.956310218535, 8379.664813407517, 8446.197611226924, 8551.828963420698, 8565.871511927326, 8574.657013719507, 6745.258021617618, 6787.287334829772, 6788.253292137861, 6845.0759147514445, 6849.04113424121, 6223.906641400473, 6332.493400528039, 6382.36176382358, 6391.392817682313, 6402.199725034371, 7483.214262502359, 7583.848323033398, 7593.240675932362, 7610.238976102345, 7752.689892404241, 7860.882086768589, 7869.409794265339, 7886.921130788848, 7930.286274235346, 7987.201279871966, 6341.270753863365, 6432.935670643234, 6658.067870498037, 6705.731770729116, 6754.729810807513, 7269.672864720995, 7316.158641756266, 7317.121945366377, 7349.0, 7358.77923662291, 6781.42357899584, 6801.387875091265, 6813.4549236061985, 7034.718611255493, 7045.1898031727005, 6734.22556406, 6791.45668346541, 6794.048833163262, 6913.861722765617, 6952.756653517103, 6650.9667451662435, 6688.6990085445295, 6704.530682852349, 6745.797626071226, 6765.2896445872475, 6265.686715664107, 6274.372562743689, 6282.654454004891, 6309.716062777278, 6321.747130114928, 6010.9699451502465, 6082.5438092142385, 6082.543809214415, 6082.90507708599, 6092.421219984094], "ext.html": [582.0890306670061, 592.552622769809, 593.0896074525599, 595.9374265702102, 606.3784620763716, 35138.824305878465, 36067.2786544269, 36300.636993630054, 36428.63571364289, 36434.0, 41646.16707665845, 42263.78868105663, 42498.36252456216, 42526.362104568376, 42597.0, 8864.689735859247, 8994.055624159468, 9015.233705135071, 9031.729048128567, 9033.638654453815, 8745.606447709868, 8783.692570760024, 8798.6920457784, 8821.338399620023, 8859.734207973772, 8778.64885404583, 8792.780180495507, 8829.293656507496, 8834.734957951272, 8878.156575125353, 8727.170918762708, 8842.336824738139, 8847.867281990775, 8855.424397414148, 8872.822543549093, 8712.912870871274, 8854.822903541894, 8861.512616806072, 8877.0, 8878.86681699775, 38928.22143557142, 39568.0, 39574.60425395738, 39610.60389396098, 39624.405633915514, 3192.776505644606, 3204.8718051278156, 3238.5627940228237, 3243.383757086146, 3347.5146103815055, 29291.0, 29645.45490679278, 29842.70157298421, 30067.69932300671, 30345.848270758725, 3353.7484688648206, 3357.529945807589, 3376.0418957004877, 3378.294581334554, 3391.16916355492, 275912.0, 276220.61889690626, 276574.0, 276788.0, 277268.0, 41305.38041929373, 55727.72136139374, 56056.71971640116, 56164.71917640386, 56194.438055619736, 40822.79588602038, 40827.59172408238, 40913.38629920554, 40927.0, 41004.38493422601, 13182.143160694524, 13283.070185087145, 13315.334233288297, 13341.19952802835, 13401.597952061455, 10424.635137770141, 10443.791124177475, 10475.84286235707, 10490.0, 10536.683899483029, 13881.791773123412, 13901.235432051131, 14039.50861719835, 14215.218163000927, 14276.857231427553, 5786.739596718157, 5838.7080645967535, 5871.915470008171, 5913.881722365529, 5986.73059712314, 942.9764255893521, 969.471637957315, 1022.8414595737672, 1070.7055559720984, 1141.8972292493715, 27748.86125569359, 28469.145925622266, 28494.717737701852, 32079.51880721791, 32355.838220808746, 1030.9278350515392, 1035.7307100154014, 1039.2205845615788, 1042.8331466965249, 1051.7160366700948, 13064.804027939588, 13110.939099603102, 13144.882684971693, 13185.60443186706, 13224.801627975588, 403050.0, 408792.0, 409458.0, 412737.0, 414578.0, 51745.48254517482, 52129.2180617291, 52180.73909630428, 52224.216636750476, 52492.21261681078, 1339.6650837290676, 1341.8322709661293, 1348.9208633093485, 1351.2703140304125, 1354.0386325708857, 24333.878330608233, 25081.623775643744, 25242.747572524775, 25324.49351013006, 25532.61701074448, 41998.1600367997, 42794.5720542803, 42830.78584607182, 42841.357379638706, 42873.0, 296282.0, 296968.0, 298720.0, 299023.0, 299640.0, 31707.0, 45109.0978180428, 45258.53901770132, 46282.537174627825, 46368.0, 42783.35824962566, 42906.14187716166, 43069.569304306555, 43591.0, 44046.559534404245, 36131.81934090313, 36949.27434970898, 37324.0, 37385.2522949534, 37743.0, 36262.27475450529, 36839.3422295992, 36862.44706329461, 37078.44382334321, 37250.06874828151, 34932.47601286034, 35394.8230258847, 35693.28613427769, 35703.46444803382, 36013.81993090018, 30777.384452311275, 33438.66561334355, 33806.830965845016, 33832.66167338295, 33956.0, 26590.468190636468, 27727.0, 27730.722692773623, 27768.305792355353, 27811.165665030083], "prototype.html": [302.4072817278135, 309.8667572943635, 310.8119587649472, 316.7560978046904, 317.25445203771125, 6222.097795819604, 6343.429091381775, 6368.395002474769, 6408.839779005515, 6421.8715625687455, 6279.780207692732, 6307.085472606469, 6309.905351419732, 6328.493720502361, 6336.588121772082, 4707.05858828234, 4759.690620109699, 4791.544803243686, 4799.976000119995, 4808.567228949394, 4787.449443314012, 4803.2795080738, 4817.181079216524, 4852.563269305761, 4866.756662166895, 4784.043191361724, 4791.520847915215, 4797.0, 4798.616110711135, 4811.59101476375, 4778.235482322829, 4796.592289655384, 4801.375821143247, 4815.0, 4818.542238487338, 4099.139180772041, 4175.832966681329, 4190.329547272422, 4194.266003449415, 4205.474315710536, 5956.821295361103, 5999.310079340888, 6025.397460253984, 6026.126211699279, 6027.849303767441, 5552.222688823527, 5593.74828132735, 5602.7758889644365, 5606.999999999959, 5614.29821272341, 6617.172853393326, 6706.0, 6727.596344219313, 6732.427743641796, 6746.494012949049, 4550.408446901882, 4589.747563883985, 4598.3102534620075, 4600.6549508786975, 4602.401687780601, 6925.965370173117, 6940.930590694079, 6951.860962780716, 6986.0, 6986.580805151656, 4678.017616300547, 4679.087577922341, 4694.037722266927, 4697.6711630185555, 4697.976510117427, 4652.488226295105, 4737.526247375235, 4740.502247264057, 4751.572358487752, 4758.214894542361, 5523.530499907472, 5538.529225015838, 5540.612157148961, 5542.473465020817, 5544.085225937756, 6803.591784492946, 6812.14848143982, 6816.829579260459, 6821.658917054227, 6828.0, 1641.7537369394447, 1675.7235056215832, 1677.429673910876, 1680.4034567728525, 1681.1678219281534, 1098.280626189847, 1104.9060829829555, 1110.4780753046055, 1121.6018313498753, 1157.2767020612118, 6421.967890160519, 6515.934840651627, 6517.217933847968, 6531.575447595891, 6536.509761767887, 6994.720211191597, 7026.754063607851, 7060.752873649398, 7065.6113913735235, 7067.469939754436, 6550.574212676161, 6606.0, 6607.306232845578, 6614.603123812587, 6624.867502650017, 3750.849966001384, 3789.317922773872, 3795.582485926546, 3821.3121638104853, 3831.3295173344554, 7362.44781641379, 7370.078740157481, 7375.668094935741, 7399.963000185072, 7422.220666830013, 7207.495475316782, 7235.638218089074, 7244.710211591583, 7245.8550828983125, 7285.7814265572115, 7145.249748776408, 7309.0, 7333.4499912507845, 7356.043714317211, 7357.3378395943555, 7045.978333141563, 7048.823779405351, 7049.224585295511, 7062.540934839219, 7078.8938165928585, 6962.3037696231995, 6983.930160698531, 6989.475789315923, 7016.22821489646, 7031.402330801735, 7244.384227340735, 7380.298871607189, 7382.889256661047, 7400.925990740024, 7407.518511296748, 4523.2988886722615, 4591.127685739699, 4609.446866375923, 4615.907681846412, 4618.815247390201, 6999.0551275577145, 6999.160100787938, 7069.116360454943, 7071.7878463646175, 7081.752138675121, 6684.4318232950745, 6798.320167983162, 6815.0, 6832.965835170792, 6841.657917104224, 6791.626460544718, 6793.66031698423, 6810.421114205348, 6819.522633415613, 6844.760433385007, 6566.606003639797, 6634.867302654016, 6681.532292739462, 6681.732730690718, 6695.866082678416, 6679.365460281266, 6827.2490026098085, 6832.863342733018, 6836.521443499107, 6840.760573379908, 6544.476441884733, 6609.20689517261, 6610.8016759497295, 6627.1716035495565, 6666.400023997863], "yui.html": [732.857092866891, 740.8296091898864, 754.6151462753994, 849.8215374771298, 861.9784505387366, 13503.122297050684, 13669.0, 13703.520376786815, 13755.0, 13755.243461609607, 13009.609711708641, 13140.540081097164, 13163.868361316385, 14068.155910645368, 14136.0, 799.9960000199991, 806.7499075286651, 807.0476837331946, 808.2321794295414, 808.8665370213907, 814.1288820961544, 814.5967745965755, 815.213319147023, 816.8039670479102, 819.7581713394533, 848.440029580477, 849.0448245723561, 852.4842470305468, 853.0190281176634, 855.8117214212863, 843.8987321521396, 846.4371193156605, 849.0914721248267, 849.1296421168321, 857.8069934264803, 619.0806652121596, 622.2129006806393, 623.8190924631851, 623.9032949892728, 627.8587317853492, 12764.680882977907, 12782.552610658675, 12796.872031279754, 12903.612891613267, 12920.741585168244, 10912.781744365147, 11025.724356891062, 11083.224174307801, 11089.611863584736, 11202.439878006067, 9675.274354423447, 9710.320277580573, 9710.368826026286, 9843.458609776459, 9852.0, 3441.208522039945, 3547.130952916526, 3567.8751243706347, 3678.6873115785193, 3764.2471505698695, 42247.155056899, 43442.34836477455, 47677.0, 47707.28439073417, 49062.26406603904, 9159.862602060974, 9334.20659243972, 9381.90618093824, 9444.622215111456, 9452.43285402878, 17503.73744393835, 18037.098145092692, 18039.203923391895, 18100.45698629043, 18153.0, 7801.843963120706, 7831.6475758591005, 7841.372690184771, 7869.1737367576725, 7961.084475285416, 4231.217224813419, 4281.892952676208, 4349.521552629209, 4365.934510982338, 4390.846320378771, 2960.733533981952, 2962.555616657519, 2968.495355789521, 2974.568687540338, 2980.1208643450236, 469.38979326874926, 470.4448750474473, 473.37987236720005, 474.29803890242636, 480.0878331170803, 569.9401562835925, 641.9807405777834, 665.125360151409, 673.5083389125867, 681.1621705302506, 8374.0, 8512.361572882059, 8625.223729864343, 8632.179942905414, 8690.08754080825, 525.1204232909861, 539.6487810695625, 624.781326535718, 637.4390536328002, 671.6473851228046, 3768.0, 3769.8115094245177, 3777.58446570877, 3826.100866296418, 3852.691784657277, 51363.743181283855, 55955.440445595836, 56192.15711764327, 56481.43518564762, 57803.0, 47836.0, 50527.7473612637, 51060.0, 51215.743921280155, 51894.48105518897, 44229.0, 44540.0, 44603.99999999935, 45178.32232516515, 45319.32021019687, 8277.95861020691, 8732.301415886586, 9265.166135047879, 9299.256059515088, 9379.953100234456, 34503.65496345004, 34525.65474345224, 34830.0, 35041.42436071091, 35661.28677426489, 40380.1923961525, 44286.77856610825, 44373.55626443694, 45331.0, 45364.773176135226, 7771.300582947561, 7772.57250851186, 7812.726554570563, 7944.364450844034, 8148.918510814816, 11875.228110172811, 12005.0, 12112.818307725214, 12138.635840924786, 12702.30137342455, 11751.294922304689, 11781.941090294493, 11942.223755455867, 11954.149289513634, 12050.096242782001, 11075.335479871233, 11133.332000080021, 11205.215634905479, 11772.426925734982, 12280.75438491243, 10787.730306742395, 10793.946030269799, 11040.779184416428, 11073.723156921142, 12037.879621203676, 9653.0, 9946.303758736818, 10099.192064634959, 10121.392716437038, 10354.896451035393, 9542.809143816947, 10262.743431414274, 10307.330023548446, 10315.535800889129, 10424.166066714797]}, "summary": {"lowerIsBetter": false, "suite": 6657.593293440966, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6855.693284166745, "unit": "ms", "value": 6855.693284166745}, "dojo.html": {"lowerIsBetter": false, "filtered": 5416.622048528491, "unit": "ms", "value": 5416.622048528491}, "mootools.html": {"lowerIsBetter": false, "filtered": 4189.392759137543, "unit": "ms", "value": 4189.392759137543}, "ext.html": {"lowerIsBetter": false, "filtered": 17952.43057926583, "unit": "ms", "value": 17952.43057926583}, "prototype.html": {"lowerIsBetter": false, "filtered": 5062.805270499885, "unit": "ms", "value": 5062.805270499885}, "yui.html": {"lowerIsBetter": false, "filtered": 6157.746570449284, "unit": "ms", "value": 6157.746570449284}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-016.e"}, "testrun": {"date": 1447679979, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 162.0, 164.0, 162.0, 162.0, 165.0, 169.0, 162.0], "ai-astar": [113.0, 104.0, 111.0, 110.0, 112.0, 123.0, 111.0, 110.0, 111.0, 111.0], "imaging-gaussian-blur": [111.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "audio-beat-detection": [150.0, 126.0, 157.0, 158.0, 129.0, 154.0, 157.0, 135.0, 163.0, 130.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 69.0, 69.0, 70.0, 68.0, 70.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [143.0, 151.0, 164.0, 163.0, 150.0, 148.0, 159.0, 151.0, 150.0, 138.0], "json-parse-financial": [62.0, 62.0, 63.0, 66.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 67.0, 68.0, 66.0, 71.0, 68.0, 67.0, 66.0, 67.0], "audio-fft": [72.0, 74.0, 73.0, 73.0, 72.0, 143.0, 73.0, 72.0, 72.0, 72.0], "imaging-darkroom": [148.0, 146.0, 147.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [117.0, 117.0, 121.0, 116.0, 127.0, 128.0, 130.0, 123.0, 121.0, 119.0], "audio-oscillator": [90.0, 91.0, 135.0, 89.0, 91.0, 92.0, 138.0, 92.0, 90.0, 146.0], "stanford-crypto-aes": [84.0, 85.0, 95.0, 94.0, 86.0, 84.0, 87.0, 85.0, 84.0, 92.0], "imaging-desaturate": [97.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0, 97.0, 97.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1519.9000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.6, "unit": "ms", "value": 79.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.7, "unit": "ms", "value": 151.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.9, "unit": "ms", "value": 145.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.9, "unit": "ms", "value": 121.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.2, "unit": "ms", "value": 63.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.4, "unit": "ms", "value": 105.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.6, "unit": "ms", "value": 111.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.2, "unit": "ms", "value": 163.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.0, "unit": "ms", "value": 69.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.6, "unit": "ms", "value": 87.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.6, "unit": "ms", "value": 96.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-016.e"}, "testrun": {"date": 1447679979, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.12475859405177], "Encrypt": [284.9002849002849], "NavierStokes": [4822.115384615385], "Decrypt": [5050.50505050505], "Splay": [556.8432671081678], "Richards": [164.06890894175552], "RegExp": [25743.589743589742], "Earley": [716.8458781362007], "Boyer": [12280.487804878048], "RayTrace": [1058.2010582010582]}, "summary": {"lowerIsBetter": false, "suite": 21512.0429923657, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.35900399999997, "unit": "score", "value": 342.35900399999997}, "Encrypt": {"lowerIsBetter": false, "filtered": 934.2953100000001, "unit": "score", "value": 934.2953100000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 146.34459068384535, "unit": "score", "value": 146.34459068384535}, "RegExp": {"lowerIsBetter": false, "filtered": 35.38686752988046, "unit": "score", "value": 35.38686752988046}, "Richards": {"lowerIsBetter": false, "filtered": 215.16568999999998, "unit": "score", "value": 215.16568999999998}, "Earley": {"lowerIsBetter": false, "filtered": 929.7158849999997, "unit": "score", "value": 929.7158849999997}, "Boyer": {"lowerIsBetter": false, "filtered": 54.27007547169812, "unit": "score", "value": 54.27007547169812}, "RayTrace": {"lowerIsBetter": false, "filtered": 699.2896049999997, "unit": "score", "value": 699.2896049999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-016.e"}, "testrun": {"date": 1447679979, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 05:39:49 INFO - RETURN: dromaeo_css: 6657.59 05:39:49 INFO - RETURN: kraken: 1519.90 05:39:49 INFO - RETURN: v8_7: 21512.04 05:39:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21512.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6657.59"}}} 05:39:49 INFO - Return code: 0 05:39:49 INFO - # TBPL SUCCESS # 05:39:49 INFO - Running post-action listener: _resource_record_post_action 05:39:49 INFO - Running post-run listener: _resource_record_post_run 05:39:50 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510283776; Read time: 12; Write time: 475388 05:39:50 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 189239296; Read time: 0; Write time: 204588 05:39:50 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280322048; Read time: 12; Write time: 133432 05:39:50 INFO - Running post-run listener: _upload_blobber_files 05:39:50 INFO - Blob upload gear active. 05:39:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:39:50 INFO - Copying logs to upload dir... 05:39:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.851350 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-16 05:39:50.126696) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:50.130332) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010097 build_url: 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:50.182468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:50.182806) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447674972.329631-385099137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:50.232825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:39:50.233160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:39:50.233472) ========= ========= Total master_lag: 0.23 =========