builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1447631975.47 results: success (0) buildid: 20151115143002 builduid: b882068eda24497e846fdcf15727dd69 revision: 4db778666e327b863b1471fa2de5f128a894460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.472324) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.472950) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.473284) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002949 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.535420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.535747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.567419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.567742) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030393 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.614935) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.615330) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.615867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:35.616253) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 15:59: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% 227M=0s 2015-11-15 15:59:35 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.503217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.132525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.132908) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.124180 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.269772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.270197) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4db778666e327b863b1471fa2de5f128a894460c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4db778666e327b863b1471fa2de5f128a894460c --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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 15:59:36,160 truncating revision to first 12 chars 2015-11-15 15:59:36,160 Setting DEBUG logging. 2015-11-15 15:59:36,160 attempt 1/10 2015-11-15 15:59:36,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4db778666e32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 15:59:36,538 unpacking tar archive at: b2g-inbound-4db778666e32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.965015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.965672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.975629) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.976061) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 15:59:36.976610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-15 15:59:36.976960) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:59:37 INFO - MultiFileLogger online at 20151115 15:59:37 in /builds/slave/test-pgo 15:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 15:59:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:59:37 INFO - {'append_to_log': False, 15:59:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:59:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 15:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:59:37 INFO - 'branch': 'B2G-Inbound', 15:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:37 INFO - 'config_files': ('talos/linux_config.py',), 15:59:37 INFO - 'default_actions': ('clobber', 15:59:37 INFO - 'read-buildbot-config', 15:59:37 INFO - 'download-and-extract', 15:59:37 INFO - 'populate-webroot', 15:59:37 INFO - 'create-virtualenv', 15:59:37 INFO - 'install', 15:59:37 INFO - 'run-tests'), 15:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:37 INFO - 'download_minidump_stackwalk': True, 15:59:37 INFO - 'download_symbols': 'ondemand', 15:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:37 INFO - 'installer_path': 'installer.exe', 15:59:37 INFO - 'log_level': 'info', 15:59:37 INFO - 'log_name': 'talos', 15:59:37 INFO - 'log_to_console': True, 15:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:59:37 INFO - 'opt_config_files': (), 15:59:37 INFO - 'pip_index': False, 15:59:37 INFO - 'sps_profile': False, 15:59:37 INFO - 'sps_profile_interval': 0, 15:59:37 INFO - 'suite': 'dromaeojs', 15:59:37 INFO - 'system_bits': '64', 15:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:37 INFO - 'title': 'talos-linux64-ix-042', 15:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:37 INFO - 'use_talos_json': True, 15:59:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:37 INFO - 'work_dir': 'build'} 15:59:37 INFO - ##### 15:59:37 INFO - ##### Running clobber step. 15:59:37 INFO - ##### 15:59:37 INFO - Running pre-action listener: _resource_record_pre_action 15:59:37 INFO - Running main action method: clobber 15:59:37 INFO - rmtree: /builds/slave/test-pgo/build 15:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:59:38 INFO - Running post-action listener: _resource_record_post_action 15:59:38 INFO - ##### 15:59:38 INFO - ##### Running read-buildbot-config step. 15:59:38 INFO - ##### 15:59:38 INFO - Running pre-action listener: _resource_record_pre_action 15:59:38 INFO - Running main action method: read_buildbot_config 15:59:38 INFO - Using buildbot properties: 15:59:38 INFO - { 15:59:38 INFO - "properties": { 15:59:38 INFO - "buildnumber": 969, 15:59:38 INFO - "product": "firefox", 15:59:38 INFO - "script_repo_revision": "production", 15:59:38 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 15:59:38 INFO - "repository": "", 15:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 15:59:38 INFO - "buildid": "20151115143002", 15:59:38 INFO - "slavename": "talos-linux64-ix-042", 15:59:38 INFO - "pgo_build": "True", 15:59:38 INFO - "basedir": "/builds/slave/test-pgo", 15:59:38 INFO - "project": "", 15:59:38 INFO - "platform": "ubuntu64_hw", 15:59:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:59:38 INFO - "slavebuilddir": "test", 15:59:38 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 15:59:38 INFO - "branch": "b2g-inbound", 15:59:38 INFO - "repo_path": "integration/b2g-inbound", 15:59:38 INFO - "stage_platform": "linux64-pgo", 15:59:38 INFO - "builduid": "b882068eda24497e846fdcf15727dd69", 15:59:38 INFO - "revision": "4db778666e327b863b1471fa2de5f128a894460c" 15:59:38 INFO - }, 15:59:38 INFO - "sourcestamp": { 15:59:38 INFO - "repository": "", 15:59:38 INFO - "hasPatch": false, 15:59:38 INFO - "project": "", 15:59:38 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:59:38 INFO - "changes": [ 15:59:38 INFO - { 15:59:38 INFO - "category": null, 15:59:38 INFO - "files": [ 15:59:38 INFO - { 15:59:38 INFO - "url": null, 15:59:38 INFO - "name": "https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:59:38 INFO - } 15:59:38 INFO - ], 15:59:38 INFO - "repository": "", 15:59:38 INFO - "rev": "4db778666e327b863b1471fa2de5f128a894460c", 15:59:38 INFO - "who": "sendchange", 15:59:38 INFO - "when": 1447631931, 15:59:38 INFO - "number": 6664172, 15:59:38 INFO - "comments": "", 15:59:38 INFO - "project": "", 15:59:38 INFO - "at": "Sun 15 Nov 2015 15:58:51", 15:59:38 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:59:38 INFO - "revlink": "", 15:59:38 INFO - "properties": [ 15:59:38 INFO - [ 15:59:38 INFO - "buildid", 15:59:38 INFO - "20151115143002", 15:59:38 INFO - "Change" 15:59:38 INFO - ], 15:59:38 INFO - [ 15:59:38 INFO - "builduid", 15:59:38 INFO - "b882068eda24497e846fdcf15727dd69", 15:59:38 INFO - "Change" 15:59:38 INFO - ], 15:59:38 INFO - [ 15:59:38 INFO - "pgo_build", 15:59:38 INFO - "True", 15:59:38 INFO - "Change" 15:59:38 INFO - ] 15:59:38 INFO - ], 15:59:38 INFO - "revision": "4db778666e327b863b1471fa2de5f128a894460c" 15:59:38 INFO - } 15:59:38 INFO - ], 15:59:38 INFO - "revision": "4db778666e327b863b1471fa2de5f128a894460c" 15:59:38 INFO - } 15:59:38 INFO - } 15:59:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:59:38 INFO - Running post-action listener: _resource_record_post_action 15:59:38 INFO - ##### 15:59:38 INFO - ##### Running download-and-extract step. 15:59:38 INFO - ##### 15:59:38 INFO - Running pre-action listener: _resource_record_pre_action 15:59:38 INFO - Running main action method: download_and_extract 15:59:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:59: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')]} 15:59:38 INFO - https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/test_packages.json 15:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/test_packages.json 15:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:59:39 INFO - Downloaded 1302 bytes. 15:59:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:59:39 INFO - Using the following test package requirements: 15:59:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'jsshell-linux-x86_64.zip'], 15:59:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:39 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')]} 15:59:39 INFO - https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:40 INFO - Downloaded 22443442 bytes. 15:59:40 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 15:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:40 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 15:59:41 INFO - Return code: 0 15:59:41 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 15:59:41 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')]} 15:59:41 INFO - https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:43 INFO - Downloaded 22443442 bytes. 15:59:43 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 15:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:59:43 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 15:59:44 INFO - Return code: 0 15:59:44 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')]} 15:59:44 INFO - https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:45 INFO - Downloaded 11131693 bytes. 15:59:45 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 15:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:45 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 15:59:45 INFO - Return code: 0 15:59:45 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')]} 15:59:45 INFO - https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:59:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:59:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cfXAryOnQnewYXg3z4YS3g/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 15:59:46 INFO - Downloaded 57170081 bytes. 15:59:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:59:46 INFO - mkdir: /builds/slave/test-pgo/properties 15:59:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:59:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:59:46 INFO - Contents: 15:59:46 INFO - build_url:https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:59:46 INFO - Running post-action listener: _resource_record_post_action 15:59:46 INFO - Running post-action listener: set_extra_try_arguments 15:59:46 INFO - ##### 15:59:46 INFO - ##### Running populate-webroot step. 15:59:46 INFO - ##### 15:59:46 INFO - Running pre-action listener: _resource_record_pre_action 15:59:46 INFO - Running main action method: populate_webroot 15:59:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:59:46 INFO - '../fennec_ids.txt'], 15:59:46 INFO - 'tests': ['tcheck2']}, 15:59:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:46 INFO - '--tppagecycles', 15:59:46 INFO - '7'], 15:59:46 INFO - 'tests': ['tsvgm']}}, 15:59:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:59:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:59:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'tests': ['damp', 'tps']}, 15:59:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['damp', 'tps']}, 15:59:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:46 INFO - 'other': {'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'other_l64': {'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:46 INFO - 'ts_paint', 15:59:46 INFO - 'tpaint', 15:59:46 INFO - 'sessionrestore', 15:59:46 INFO - 'sessionrestore_no_auto_restore']}, 15:59:46 INFO - 'svgr': {'tests': ['tsvgx', 15:59:46 INFO - 'tsvgr_opacity', 15:59:46 INFO - 'tart', 15:59:46 INFO - 'tscrollx', 15:59:46 INFO - 'cart']}, 15:59:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['tsvgx', 15:59:46 INFO - 'tsvgr_opacity', 15:59:46 INFO - 'tart', 15:59:46 INFO - 'tscrollx', 15:59:46 INFO - 'cart']}, 15:59:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'tests': ['tp5o']}, 15:59:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'talos_options': ['--e10s'], 15:59:46 INFO - 'tests': ['tp5o']}, 15:59:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'talos_options': ['--xperf_path', 15:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:46 INFO - 'tests': ['tp5n']}, 15:59:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:46 INFO - 'talos_options': ['--e10s', 15:59:46 INFO - '--xperf_path', 15:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:46 INFO - 'tests': ['tp5n']}}, 15:59:46 INFO - 'talos.zip': {'path': '', 15:59:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:46 INFO - Running post-action listener: _resource_record_post_action 15:59:46 INFO - ##### 15:59:46 INFO - ##### Running create-virtualenv step. 15:59:46 INFO - ##### 15:59:46 INFO - Running pre-action listener: _resource_record_pre_action 15:59:46 INFO - Running main action method: create_virtualenv 15:59:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:59:46 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 15:59:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:59:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:47 INFO - Using real prefix '/usr' 15:59:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:59:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:54 INFO - Installing pip.................done. 15:59:54 INFO - Return code: 0 15:59:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:59:54 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')]} 15:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:54 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')]} 15:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:54 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 15:59:54 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 15:59:54 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 15:59:54 INFO - Using env: {'DISPLAY': ':0', 15:59:54 INFO - 'HOME': '/home/cltbld', 15:59:54 INFO - 'LANG': 'en_US.UTF-8', 15:59:54 INFO - 'LANGUAGE': 'en_US:en', 15:59:54 INFO - 'LOGNAME': 'cltbld', 15:59:54 INFO - 'MAIL': '/var/mail/cltbld', 15:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:54 INFO - 'MOZ_NO_REMOTE': '1', 15:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:54 INFO - 'NO_EM_RESTART': '1', 15:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:54 INFO - 'SHELL': '/bin/bash', 15:59:54 INFO - 'SHLVL': '1', 15:59:54 INFO - 'TERM': 'linux', 15:59:54 INFO - 'TMOUT': '86400', 15:59:54 INFO - 'USER': 'cltbld', 15:59:54 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 15:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:54 INFO - '_': '/tools/buildbot/bin/python'} 15:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:56 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 15:59:56 INFO - Cleaning up... 15:59:56 INFO - Return code: 0 15:59:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:56 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 15:59:56 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 15:59:56 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 15:59:56 INFO - Using env: {'DISPLAY': ':0', 15:59:56 INFO - 'HOME': '/home/cltbld', 15:59:56 INFO - 'LANG': 'en_US.UTF-8', 15:59:56 INFO - 'LANGUAGE': 'en_US:en', 15:59:56 INFO - 'LOGNAME': 'cltbld', 15:59:56 INFO - 'MAIL': '/var/mail/cltbld', 15:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:56 INFO - 'MOZ_NO_REMOTE': '1', 15:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:56 INFO - 'NO_EM_RESTART': '1', 15:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:56 INFO - 'SHELL': '/bin/bash', 15:59:56 INFO - 'SHLVL': '1', 15:59:56 INFO - 'TERM': 'linux', 15:59:56 INFO - 'TMOUT': '86400', 15:59:56 INFO - 'USER': 'cltbld', 15:59:56 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 15:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:56 INFO - '_': '/tools/buildbot/bin/python'} 15:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:56 INFO - Downloading/unpacking psutil>=0.7.1 15:59:56 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 15:59:56 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 15:59:56 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 15:59:56 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 15:59:56 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 15:59:56 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 15:59:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:58 INFO - Installing collected packages: psutil 15:59:58 INFO - Running setup.py install for psutil 15:59:58 INFO - building 'psutil._psutil_linux' extension 15:59:58 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 15:59:59 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 16:00:00 INFO - building 'psutil._psutil_posix' extension 16:00:00 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 16:00:00 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 16:00:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:00 INFO - Successfully installed psutil 16:00:00 INFO - Cleaning up... 16:00:00 INFO - Return code: 0 16:00:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:00:00 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')]} 16:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 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')]} 16:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 16:00:00 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 16:00:00 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 16:00:00 INFO - Using env: {'DISPLAY': ':0', 16:00:00 INFO - 'HOME': '/home/cltbld', 16:00:00 INFO - 'LANG': 'en_US.UTF-8', 16:00:00 INFO - 'LANGUAGE': 'en_US:en', 16:00:00 INFO - 'LOGNAME': 'cltbld', 16:00:00 INFO - 'MAIL': '/var/mail/cltbld', 16:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:00 INFO - 'MOZ_NO_REMOTE': '1', 16:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:00 INFO - 'NO_EM_RESTART': '1', 16:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:00 INFO - 'SHELL': '/bin/bash', 16:00:00 INFO - 'SHLVL': '1', 16:00:00 INFO - 'TERM': 'linux', 16:00:00 INFO - 'TMOUT': '86400', 16:00:00 INFO - 'USER': 'cltbld', 16:00:00 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:00 INFO - '_': '/tools/buildbot/bin/python'} 16:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:00:00 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 16:00:00 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 16:00:00 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 16:00:00 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 16:00:00 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 16:00:00 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 16:00:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:00:02 INFO - Installing collected packages: mozsystemmonitor 16:00:02 INFO - Running setup.py install for mozsystemmonitor 16:00:02 INFO - Successfully installed mozsystemmonitor 16:00:02 INFO - Cleaning up... 16:00:02 INFO - Return code: 0 16:00:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:00:02 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')]} 16:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:02 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')]} 16:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:02 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 16:00:02 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 16:00:02 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 16:00:02 INFO - Using env: {'DISPLAY': ':0', 16:00:02 INFO - 'HOME': '/home/cltbld', 16:00:02 INFO - 'LANG': 'en_US.UTF-8', 16:00:02 INFO - 'LANGUAGE': 'en_US:en', 16:00:02 INFO - 'LOGNAME': 'cltbld', 16:00:02 INFO - 'MAIL': '/var/mail/cltbld', 16:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:02 INFO - 'MOZ_NO_REMOTE': '1', 16:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:02 INFO - 'NO_EM_RESTART': '1', 16:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:02 INFO - 'SHELL': '/bin/bash', 16:00:02 INFO - 'SHLVL': '1', 16:00:02 INFO - 'TERM': 'linux', 16:00:02 INFO - 'TMOUT': '86400', 16:00:02 INFO - 'USER': 'cltbld', 16:00:02 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:02 INFO - '_': '/tools/buildbot/bin/python'} 16:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:04 INFO - Downloading blobuploader-1.2.4.tar.gz 16:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:00:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:00:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:05 INFO - Downloading docopt-0.6.1.tar.gz 16:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:00:05 INFO - Installing collected packages: blobuploader, requests, docopt 16:00:05 INFO - Running setup.py install for blobuploader 16:00:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:00:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:00:05 INFO - Running setup.py install for requests 16:00:05 INFO - Running setup.py install for docopt 16:00:05 INFO - Successfully installed blobuploader requests docopt 16:00:05 INFO - Cleaning up... 16:00:05 INFO - Return code: 0 16:00:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:05 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')]} 16:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:05 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')]} 16:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:05 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 16:00:05 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 16:00:05 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 16:00:05 INFO - Using env: {'DISPLAY': ':0', 16:00:05 INFO - 'HOME': '/home/cltbld', 16:00:05 INFO - 'LANG': 'en_US.UTF-8', 16:00:05 INFO - 'LANGUAGE': 'en_US:en', 16:00:05 INFO - 'LOGNAME': 'cltbld', 16:00:05 INFO - 'MAIL': '/var/mail/cltbld', 16:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:05 INFO - 'MOZ_NO_REMOTE': '1', 16:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:05 INFO - 'NO_EM_RESTART': '1', 16:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:05 INFO - 'SHELL': '/bin/bash', 16:00:05 INFO - 'SHLVL': '1', 16:00:05 INFO - 'TERM': 'linux', 16:00:05 INFO - 'TMOUT': '86400', 16:00:05 INFO - 'USER': 'cltbld', 16:00:05 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:05 INFO - '_': '/tools/buildbot/bin/python'} 16:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:05 INFO - Running setup.py (path:/tmp/pip-9w2H2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:06 INFO - Running setup.py (path:/tmp/pip-fQsKxp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:06 INFO - Running setup.py (path:/tmp/pip-alAwiW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:06 INFO - Running setup.py (path:/tmp/pip-cbZC59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:06 INFO - Running setup.py (path:/tmp/pip-8sz4sq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:06 INFO - Running setup.py (path:/tmp/pip-mAyehC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:06 INFO - Running setup.py (path:/tmp/pip-VuyHW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:06 INFO - Running setup.py (path:/tmp/pip-LZ1sKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:06 INFO - Running setup.py (path:/tmp/pip-2tfI5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:06 INFO - Running setup.py (path:/tmp/pip-RY0zrc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:06 INFO - Running setup.py (path:/tmp/pip-KhxsNX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:06 INFO - Running setup.py (path:/tmp/pip-I0VFOK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:06 INFO - Running setup.py (path:/tmp/pip-pgC5IX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:06 INFO - Running setup.py (path:/tmp/pip-P1dhHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:06 INFO - Running setup.py (path:/tmp/pip-qNXSRn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:07 INFO - Running setup.py (path:/tmp/pip-lRfcnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:07 INFO - Running setup.py (path:/tmp/pip-FqzKOR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:00:07 INFO - Running setup.py install for manifestparser 16:00:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Running setup.py install for mozcrash 16:00:07 INFO - Running setup.py install for mozdebug 16:00:07 INFO - Running setup.py install for mozdevice 16:00:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Running setup.py install for mozfile 16:00:07 INFO - Running setup.py install for mozhttpd 16:00:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Running setup.py install for mozinfo 16:00:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Running setup.py install for mozInstall 16:00:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:00:07 INFO - Running setup.py install for mozleak 16:00:08 INFO - Running setup.py install for mozlog 16:00:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Running setup.py install for moznetwork 16:00:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Running setup.py install for mozprocess 16:00:08 INFO - Running setup.py install for mozprofile 16:00:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Running setup.py install for mozrunner 16:00:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Running setup.py install for mozscreenshot 16:00:08 INFO - Running setup.py install for moztest 16:00:08 INFO - Running setup.py install for mozversion 16:00:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:08 INFO - Cleaning up... 16:00:08 INFO - Return code: 0 16:00:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:08 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')]} 16:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:08 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')]} 16:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:08 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 16:00:08 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 16:00:08 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 16:00:08 INFO - Using env: {'DISPLAY': ':0', 16:00:08 INFO - 'HOME': '/home/cltbld', 16:00:08 INFO - 'LANG': 'en_US.UTF-8', 16:00:08 INFO - 'LANGUAGE': 'en_US:en', 16:00:08 INFO - 'LOGNAME': 'cltbld', 16:00:08 INFO - 'MAIL': '/var/mail/cltbld', 16:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:08 INFO - 'MOZ_NO_REMOTE': '1', 16:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:08 INFO - 'NO_EM_RESTART': '1', 16:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:08 INFO - 'SHELL': '/bin/bash', 16:00:08 INFO - 'SHLVL': '1', 16:00:08 INFO - 'TERM': 'linux', 16:00:08 INFO - 'TMOUT': '86400', 16:00:08 INFO - 'USER': 'cltbld', 16:00:08 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:08 INFO - '_': '/tools/buildbot/bin/python'} 16:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:09 INFO - Running setup.py (path:/tmp/pip-Kr5u1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:09 INFO - Running setup.py (path:/tmp/pip-IsY_xz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:09 INFO - Running setup.py (path:/tmp/pip-ckskvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:09 INFO - Running setup.py (path:/tmp/pip-tUXdll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:09 INFO - Running setup.py (path:/tmp/pip-oEpxUG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:09 INFO - Running setup.py (path:/tmp/pip-HLKNDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:09 INFO - Running setup.py (path:/tmp/pip-Gq8xiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:09 INFO - Running setup.py (path:/tmp/pip-TJU0KM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:09 INFO - Running setup.py (path:/tmp/pip-3Yg_mV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:09 INFO - Running setup.py (path:/tmp/pip-XN7JxZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:09 INFO - Running setup.py (path:/tmp/pip-4tBj2E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:09 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)) 16:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:09 INFO - Running setup.py (path:/tmp/pip-sA4lHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:10 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)) 16:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:10 INFO - Running setup.py (path:/tmp/pip-Saky9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:10 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)) 16:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:10 INFO - Running setup.py (path:/tmp/pip-Q3zDmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:10 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)) 16:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:10 INFO - Running setup.py (path:/tmp/pip-gaAC3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:10 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)) 16:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:10 INFO - Running setup.py (path:/tmp/pip-rR0fqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:10 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)) 16:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:10 INFO - Running setup.py (path:/tmp/pip-EDWwX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:10 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)) 16:00:10 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)) 16:00:10 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)) 16:00:10 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)) 16:00:10 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)) 16:00:10 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)) 16:00:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:10 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 16:00:10 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 16:00:10 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 16:00:10 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 16:00:10 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 16:00:10 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 16:00:12 INFO - Downloading blessings-1.5.1.tar.gz 16:00:12 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 16:00:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:12 INFO - Installing collected packages: blessings 16:00:12 INFO - Running setup.py install for blessings 16:00:12 INFO - Successfully installed blessings 16:00:12 INFO - Cleaning up... 16:00:12 INFO - Return code: 0 16:00:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:00:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:12 INFO - Reading from file tmpfile_stdout 16:00:12 INFO - Current package versions: 16:00:12 INFO - argparse == 1.2.1 16:00:12 INFO - blessings == 1.5.1 16:00:12 INFO - blobuploader == 1.2.4 16:00:12 INFO - docopt == 0.6.1 16:00:12 INFO - manifestparser == 1.1 16:00:12 INFO - mozInstall == 1.12 16:00:12 INFO - mozcrash == 0.16 16:00:12 INFO - mozdebug == 0.1 16:00:12 INFO - mozdevice == 0.47 16:00:12 INFO - mozfile == 1.2 16:00:12 INFO - mozhttpd == 0.7 16:00:12 INFO - mozinfo == 0.9 16:00:12 INFO - mozleak == 0.1 16:00:12 INFO - mozlog == 3.0 16:00:12 INFO - moznetwork == 0.27 16:00:12 INFO - mozprocess == 0.22 16:00:12 INFO - mozprofile == 0.27 16:00:12 INFO - mozrunner == 6.11 16:00:12 INFO - mozscreenshot == 0.1 16:00:12 INFO - mozsystemmonitor == 0.0 16:00:12 INFO - moztest == 0.7 16:00:12 INFO - mozversion == 1.4 16:00:12 INFO - psutil == 3.1.1 16:00:12 INFO - requests == 1.2.3 16:00:12 INFO - wsgiref == 0.1.2 16:00:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:12 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')]} 16:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:12 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')]} 16:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:12 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 0x7f1e627e6c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200c3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, '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': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', '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 16:00:12 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 16:00:12 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 16:00:12 INFO - Using env: {'DISPLAY': ':0', 16:00:12 INFO - 'HOME': '/home/cltbld', 16:00:12 INFO - 'LANG': 'en_US.UTF-8', 16:00:12 INFO - 'LANGUAGE': 'en_US:en', 16:00:12 INFO - 'LOGNAME': 'cltbld', 16:00:12 INFO - 'MAIL': '/var/mail/cltbld', 16:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:12 INFO - 'MOZ_NO_REMOTE': '1', 16:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:12 INFO - 'NO_EM_RESTART': '1', 16:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:12 INFO - 'SHELL': '/bin/bash', 16:00:12 INFO - 'SHLVL': '1', 16:00:12 INFO - 'TERM': 'linux', 16:00:12 INFO - 'TMOUT': '86400', 16:00:12 INFO - 'USER': 'cltbld', 16:00:12 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:12 INFO - '_': '/tools/buildbot/bin/python'} 16:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 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)) 16:00:12 INFO - Cleaning up... 16:00:12 INFO - Return code: 0 16:00:12 INFO - Running post-action listener: _resource_record_post_action 16:00:12 INFO - Running post-action listener: _start_resource_monitoring 16:00:12 INFO - Starting resource monitoring. 16:00:12 INFO - ##### 16:00:12 INFO - ##### Running install step. 16:00:12 INFO - ##### 16:00:12 INFO - Running pre-action listener: _resource_record_pre_action 16:00:12 INFO - Running main action method: install 16:00:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:12 INFO - Reading from file tmpfile_stdout 16:00:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:00:13 INFO - Reading from file tmpfile_stdout 16:00:13 INFO - Output received: 16:00:13 INFO - Usage: mozinstall [options] installer 16:00:13 INFO - Options: 16:00:13 INFO - -h, --help show this help message and exit 16:00:13 INFO - -d DEST, --destination=DEST 16:00:13 INFO - Directory to install application into. [default: 16:00:13 INFO - "/builds/slave/test-pgo"] 16:00:13 INFO - --app=APP Application being installed. [default: firefox] 16:00:13 INFO - mkdir: /builds/slave/test-pgo/build/application 16:00:13 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'] 16:00:13 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 16:00:27 INFO - Reading from file tmpfile_stdout 16:00:27 INFO - Output received: 16:00:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:00:27 INFO - Running post-action listener: _resource_record_post_action 16:00:27 INFO - ##### 16:00:27 INFO - ##### Running run-tests step. 16:00:27 INFO - ##### 16:00:27 INFO - Running pre-action listener: _resource_record_pre_action 16:00:27 INFO - Running main action method: run_tests 16:00:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:00:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:00:27 INFO - Python 2.7.3 16:00:27 INFO - Return code: 0 16:00:27 INFO - grabbing minidump binary from tooltool 16:00:27 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')]} 16:00:27 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 0x20958c0>, '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 0x2042420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20428b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:00:27 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 16:00:27 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 16:00:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:27 INFO - Return code: 0 16:00:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:00:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:00:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:00:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:00:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 16:00:27 INFO - Using env: {'DISPLAY': ':0', 16:00:27 INFO - 'HOME': '/home/cltbld', 16:00:27 INFO - 'LANG': 'en_US.UTF-8', 16:00:27 INFO - 'LANGUAGE': 'en_US:en', 16:00:27 INFO - 'LOGNAME': 'cltbld', 16:00:27 INFO - 'MAIL': '/var/mail/cltbld', 16:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:27 INFO - 'MOZ_NO_REMOTE': '1', 16:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:27 INFO - 'NO_EM_RESTART': '1', 16:00:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:00:27 INFO - 'SHELL': '/bin/bash', 16:00:27 INFO - 'SHLVL': '1', 16:00:27 INFO - 'TERM': 'linux', 16:00:27 INFO - 'TMOUT': '86400', 16:00:27 INFO - 'USER': 'cltbld', 16:00:27 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525', 16:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:27 INFO - '_': '/tools/buildbot/bin/python'} 16:00:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 16:00:27 INFO - mozversion INFO | application_buildid: 20151115143002 16:00:27 INFO - mozversion INFO | application_changeset: 4db778666e327b863b1471fa2de5f128a894460c 16:00:27 INFO - mozversion INFO | application_display_name: Nightly 16:00:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:27 INFO - mozversion INFO | application_name: Firefox 16:00:27 INFO - mozversion INFO | application_remotingname: firefox 16:00:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:00:27 INFO - mozversion INFO | application_vendor: Mozilla 16:00:27 INFO - mozversion INFO | application_version: 45.0a1 16:00:27 INFO - mozversion INFO | platform_buildid: 20151115143002 16:00:27 INFO - mozversion INFO | platform_changeset: 4db778666e327b863b1471fa2de5f128a894460c 16:00:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:00:27 INFO - mozversion INFO | platform_version: 45.0a1 16:00:27 INFO - 2015-11-15 16:00:27,777 DEBUG : using testdate: 1447632027 16:00:27 INFO - 2015-11-15 16:00:27,777 DEBUG : actual date: 1447632027 16:00:27 INFO - 2015-11-15 16:00:27,784 INFO : starting webserver on 'localhost:55241' 16:00:27 INFO - 2015-11-15 16:00:27,785 INFO : Starting test suite talos-linux64-ix-042 16:00:27 INFO - 2015-11-15 16:00:27,785 INFO : Starting test dromaeo_css 16:00:27 INFO - 2015-11-15 16:00:27,785 DEBUG : operating with platform_type : linux_ 16:00:27 INFO - 2015-11-15 16:00:27,785 INFO : Initialising browser for dromaeo_css test... 16:00:27 INFO - 2015-11-15 16:00:27,796 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1FNxKt/profile http://localhost:55241/getInfo.html 16:00:36 INFO - 2015-11-15 16:00:36,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:00:36 INFO - 2015-11-15 16:00:36,102 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:00:36 INFO - 2015-11-15 16:00:36,102 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:00:36 INFO - 2015-11-15 16:00:36,102 DEBUG : BROWSER_OUTPUT: __metrics 16:00:36 INFO - 2015-11-15 16:00:36,219 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:00:38 INFO - 2015-11-15 16:00:38,268 INFO : Browser initialized. 16:00:38 INFO - 2015-11-15 16:00:38,268 INFO : Running cycle 1/1 for dromaeo_css test... 16:00:38 INFO - 2015-11-15 16:00:38,268 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1FNxKt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:00:50 INFO - 2015-11-15 16:00:50,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 16:00:50 INFO - 2015-11-15 16:00:50,016 DEBUG : BROWSER_OUTPUT: 16:01:41 INFO - 2015-11-15 16:01:41,638 DEBUG : BROWSER_OUTPUT: 1447632101635 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] 16:03:50 INFO - 2015-11-15 16:03:50,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55241/tests/dromaeo/cssquery-ext.html) 16:03:51 INFO - 2015-11-15 16:03:51,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 219889664 16:03:51 INFO - 2015-11-15 16:03:51,523 DEBUG : BROWSER_OUTPUT: 16:06:53 INFO - 2015-11-15 16:06:53,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-ext.html (next: http://localhost:55241/tests/dromaeo/cssquery-jquery.html) 16:06:54 INFO - 2015-11-15 16:06:54,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 219959296 16:06:54 INFO - 2015-11-15 16:06:54,413 DEBUG : BROWSER_OUTPUT: 16:09:56 INFO - 2015-11-15 16:09:56,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55241/tests/dromaeo/cssquery-mootools.html) 16:09:56 INFO - 2015-11-15 16:09:56,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 217608192 16:09:56 INFO - 2015-11-15 16:09:56,913 DEBUG : BROWSER_OUTPUT: 16:12:58 INFO - 2015-11-15 16:12:58,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55241/tests/dromaeo/cssquery-prototype.html) 16:12:59 INFO - 2015-11-15 16:12:59,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 199348224 16:12:59 INFO - 2015-11-15 16:12:59,330 DEBUG : BROWSER_OUTPUT: 16:16:01 INFO - 2015-11-15 16:16:01,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55241/tests/dromaeo/cssquery-yui.html) 16:16:02 INFO - 2015-11-15 16:16:02,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 198856704 16:16:02 INFO - 2015-11-15 16:16:02,388 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/dromaeo/cssquery-yui.html (next: http://localhost:55241/tests/dromaeo/cssquery-dojo.html) 16:19:04 INFO - 2015-11-15 16:19:04,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 258764800 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:19:04 INFO - 2015-11-15 16:19:04,901 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.490481522956;3253.284277458958;3293.6706329367066;3301.1747063234193;3307.272400071984;5250;5377.056365456544;5389.434109418514;5395;5409.513143817056;5407.810281738011;5499.50504454599;5522.779088836452;5568.331800183973;5577.051901176799;4704.725990823047;4986.301917731521;5019.272205530196;5030.773615187307;5062.493750624926;5100.923486147711;5105.234214867763;5159.793608255665;5168.974155129238;5173.456787037363;4782.569568738812;4872.731999740013;4877.51224877513;5004.099262132815;5032.144535428986;4972.055309491221;4985.775640096204;4989;4995.125852975751;5038.949610503884;4956.553910148104;4979.47715489872;4990.525900039491;4990.600751939836;5038.848834534933;5069.61977851659;5180.0157969985585;5203.323567936144;5274.894502109974;5320.654157479751;5995.400459954013;6007.339192688801;6008.008678568031;6009.2188015557695;6018.097285407181;5873.471387575139;6035.849103772397;6036.698165091728;6037.275526936752;6043.123747056652;5460.863478413072;5516.972415137939;5537.972310138423;5567.777288908479;5602.215689803431;6007.789727359609;6014.248218972629;6020.277566692025;6029;6069.817905462844;5741.224934633771;5846.064629659234;5851.941480585139;5889.087191485327;5890.4698577128265;5798.072308430716;5838.357780644125;5838.883222335615;5840.211571437886;5920.911186332209;5889.381614930457;5905.586608937333;5918.852028699317;5921.644701317849;5922.822315330547;5696.686682232434;5751.22358481608;5817.243758311392;5907.172995780594;5919.141724449931;4525.547445255514;4554.772261386917;4558.612517935946;4568.611668008257;4600.5629465200755;4044.1102957349335;4049.493813273341;4069.2878746219294;4070.715049946475;4100.1184745279315;5361;5468.7539060742365;5474.233607294982;5564.86087847799;5724.141378793214;5885.61743486672;5902.203202567598;5902.970485147633;5908.527317814564;5939.970300148471;5583.190437386556;5589.524890384281;5599.496045355938;5600.327960644749;5603.439656034364;4950.628702847301;5000.1249781288125;5038.722870242099;5045.217991211368;5082.136036873666;6143.082036032938;6279.183706118175;6283.434490895841;6292.937070629235;6298.874022519524;6002.189704389852;6027.849303767441;6043.697815109139;6047.848803779941;6062.909056364247;5962.25471816023;6007.579469437273;6066.696665166813;6074.271087469355;6249.843753906189;5845.970770146122;5858;5885.234919460443;5897.882042359214;5914.053751399755;5954.970225148846;5963.4334738199805;5976.880462390641;5978.461938425563;5984.19213406202;5503.697296648723;5601.6358936668985;5643.463870932255;5762.596618236683;5836.620619659709;5625.128105143709;5768.826935191951;5769.509591684754;5778.075507918713;5789.131630255327;5613.1860880171325;5677.914831277617;5682.119271512922;5698.971505142447;5704.914426283526;5518.503334699736;5623.100303951348;5642.633228840113;5656.773729050792;5672.517835983987;5674.319081710221;5726.141078838041;5741.712914354182;5746.942530574641;5781.797637082682 16:19:04 INFO - 2015-11-15 16:19:04,902 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.0553141793926;584.1529781816365;591.2963573347719;603.9245094363205;605.9333473317935;32553.837230813842;33491.49762753561;33541.49687754686;41216.79391603045;41431.79284103583;44246.11507769843;44791;44961.775191124;45016.3247551287;45021.32468012982;8608.827823443544;8715.259202967723;8745.825083498326;8767.167119123706;8771.692990745325;7857.8035549111155;8067.112617612058;10408.323458975181;10660.946695266513;10686.091682207021;10368.06687398134;10432;10434.217433692465;10498.895011049868;10511.947440262787;7871.0554733432355;8072.071711753165;10310.32982856112;10319.43243121628;10450.16398688103;10391.740206494822;10665.786684266348;10678.946605267001;10679.893201067967;10688.305260158066;41852.372214416806;42379.57620423787;42405.575944240474;42457;42489;3202.7758056936023;3222.8549715262634;3303.801771893694;3318.1870441741685;3676.5036720042986;30645.846770766228;31050;31460;31705;32391.352172956646;3069.2020074780494;3094.257378229209;3295.07737833407;3386.8306584670913;3427.143214196451;294807;295515;296699;297622.5832095888;298387;58927;60595.697021515494;63196.684016579624;63321.36678633155;63735.681321593096;67204.6639766798;67848;68200.6589967047;68245;68255;15077.54767356981;15294.541163765105;15397.07617542951;15442.838002679633;15489.612759681098;10662.573497060032;10811.621593244356;10825.079868211133;10836.187285953585;10837.566497340176;20049;20462.181512739622;20675.4831129223;20719.482012949495;20754.06606702702;8267.793305167299;8300.792480187924;8309.044459887069;8403.70587029451;8418.326533877274;923.2060428031887;940;1027.8561001459802;1051.9053285204368;1143.17691262291;28354.2911427216;28841.11588841099;29097.709022909923;29184.708152918625;29200.26999325034;979.4368238263028;999.5352161245056;1035.7519189376783;1117.4971262931551;1132.3602164776876;15136.924315378352;15185.468508602145;15262;15412.691746165237;15433.84566154324;324210;327061;327457;327763;328056;53152.82436870973;53628.73185634047;53674.7316263424;53695.731521342925;53704.73147634237;1221.7800795856654;1273.8662440443804;1282.2691066092425;1341.4768240386256;1344.4218985836185;26940.73059269382;28064.579031314137;28529.714702852707;28720.281992950342;29110.563341550318;48427.5157248423;48828.5117148824;48903.51096489132;49013;49215.50784492109;265747;267339;268384;269936;270026;32969.17577060593;33580.160495987795;33822.66177338195;33848.49227261642;33869.32261354809;44122.338164928195;44467.555324446344;44582.777086114365;45315.32027019663;45789.31316030196;37114.814425927696;37876.43185352277;37895.43156852594;38517.80741096276;38548.6145138545;32309.35381292314;36943.630563694016;37870;40200.597994020856;43474;40564;41049.79475102606;41126.1774764509;41276.1744765097;41457.79271103746;32042.359152816345;32218;34593.308133836676;34912.650873491955;36321.636783631824;25831.354216144748;25991.350216244744;26141.477170456863;26320.34199145037;26546.203613891616 16:19:04 INFO - 2015-11-15 16:19:04,902 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.4161924727961;343.7937237657404;343.97076248518874;344.41105709237206;346.61525706465835;14789.630259243497;14845.703085938274;16877.746833797504;17495.47513574593;18938.337158199465;15977.520674379759;16910.577235569086;17256;17557.3854915078;17611.735823962652;5316.149416093416;5442.91835622464;5453.072977593819;5460.126379779236;5460.890782184354;3855.749376290546;3967.325554655701;5401.621886467949;5441.782328706847;5749.856253593652;5895.528357731371;5907.556933230004;5914.674692891889;5920.526357891358;5935.554833387491;5812.186293918855;5925.792597259076;5926.614770039933;5928.340064781868;5935.406459354073;5072.036313100499;5096.210087436453;5137.178051511778;5144.871378215575;5154.613403994716;19906.900465497725;20385;20553.89723051375;20608.69086963697;20622.896885515478;2147.881866497342;2294.4149241943364;2351.6237402015595;2364.810815134785;2371.9525609487887;13212.075154739172;13358.265295408748;13478.797818032639;13506.392212350467;13779.724405511834;1771.5482551949171;1804.4135655911882;1814.4103166470818;1826.6529359421668;1843.4930394141584;58282.7085864568;60045.69977150086;60210.39789602092;60526;61033.20184582502;9112.362134650644;9324.689735144062;9660.95169524162;9760.951195243979;9820.705378838646;12433.813492797615;12438.751224975631;12439.37803109859;12443.751124977449;12458.875411245772;7255.854882902312;7481.738139165103;7485.251474852471;7492.175860655324;7573.35626471745;7384.556926584422;7426.14599321085;7477;7485.812854678677;7530.736424225126;5746.367899531048;5901.232839730894;5935.169076329317;5936.910946335808;5947.345791962967;1593.2989484626728;1629.3645478263486;1673.313941284092;1673.8577220936113;1675.7570152327844;904.2991681446931;915.6520522201521;985.3201291109111;1028.7376718936623;1036.4713995862164;16662.166891655368;17287.481375558753;17291.74062389065;17475.737863932052;17667.116644167996;894.3203165594196;931.9767005824908;934.8457504511815;953.9935368186491;977.4965892565334;10308.948455257825;10419.322744021614;10470.685879423629;10493.580256789643;10525.631602893862;525925;525993;526658;548057;585061;67310;75926.62036689781;76741;76845.84731229037;78001;536.3858382152491;547.2448021729987;548.314606741573;549.1351121982813;549.9532539734088;10869.510872010937;11219.102471802073;11359.886401135884;11422.771544569228;11457.713557161138;20301.28945486901;33778;34078.48882266718;36035;37131.6286837139;42475.78762106293;43785.343219852366;44118.55881441273;44350.3347449795;44909.32636010397;6517.859374609519;6556;6646.069550263063;6648.335166483313;6671.8999215010845;12429.689257768267;12524.624261272176;12538.937305313415;12699.619011429671;12715.936420318209;9341.626334946526;9639.951800240953;9857.457839818879;11115.110791136527;11294.265872718248;10804.945975270388;10808.351498910091;10824.242303039027;11036.061934735637;11152.219344645797;9380.671676491564;9691.612335506501;10793.892061079288;10923.453827308762;11062.115030797357;6530.9020364693615;6615.470762339098;6618.371254730793;6618.536702430976;6636.2700102987665;9414.388064776042;10703.839442408525;10930.180236482136;11135.443227838738;11144.442777860912 16:19:04 INFO - 2015-11-15 16:19:04,903 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1395.8045873577707;1711.9315227390905;1768;1779.7063484525054;1804.7924488683798;6862.82842928927;7490.812729681754;7627.237276272377;7632.618369081538;7639.465237433382;7735.1491335953;7827.804304892381;7845.60771961401;7849.0973538043145;7857.1357150713375;1997.8301844343248;2072.4715197624587;2285.6000199965024;2307.0886999635177;2321.3500219938446;2340.3213068210284;2340.918067867625;2344.167820423742;2347.530493901218;2350.976490235101;2251.3020963501285;2286.1769762885347;2290.198430549311;2290.6220473621916;2293.575688497625;2022.8583999120067;2067.390119914621;2265.546890621882;2298.218605674079;2301.3786277705094;2287.3595393289906;2310.295359915225;2348.894299756515;2352.4942137440535;2357.5284943011466;7819.335356494648;7900.683972641087;7904;7904.80237994049;7932.563708996003;4752.334673145762;4842.467328593852;4845.442774080955;4860.441049279343;4884;3136.325689976643;3141.890033848827;3178.761592880543;3198.9360212795614;3274.950875736866;961.2598299309562;965.9420434773936;966.4536741214072;991.2516050381987;1012.6556970630021;10906.890931090667;10910.018098371185;10916.727081823017;10918.836217456745;10943.4528273586;4294.7852607369505;4354.303311470149;4403.801828917706;4418.911621767546;4436.778161091933;9373.343865929319;9399.90600094004;9405.905940940504;9410.952945235367;9415.152636262632;4802.207635740064;4840.15297322967;4840.370751802243;4847.054824309296;4851.175300198975;4359.869203923888;4428.4243048403505;4432.246518091933;4434.312681534368;4435.689501734848;3725.590185079639;3741.7006639468777;3774.5470543534952;3801.315763162602;3820.656140947328;1224.185916365607;1227.472186959616;1229.2685851918095;1236.7031912340974;1238.0343332200898;981.5730157381562;1009.6213919780082;1037.4501514197486;1038.678009816944;1068.7167900506372;7162;7230.132384113835;7264.200937896827;7288.453365997571;7302.853942921218;1096.8903109688968;1117.0393461622998;1118.7818375416716;1120.0423637789572;1129.0628778114146;5539.529140023144;5625.971870140705;5630.577706672016;5633.69014704187;5644.3508996465935;9103.089691030977;9179.81640367189;9530.237580993504;9622.278329125204;9648.95175524132;9333.813323733488;9492.762680933032;9512.239020878313;9522.95238523803;9526.476043817518;6894.827629309207;7026.543274687129;7042.507024508338;7276.454265930077;7321.121465424183;7227.638618069181;7329.9267007329245;7332.340089391981;7340.522866013692;7360.852782944418;8165.918340816515;8288.21261980111;8426.831463370821;8430.199131082538;8434.325253979545;8502.319814414708;8662;8678.392512524062;8693.608787604699;8705.173008564176;6996.6151861648095;7197.100362454693;7230.13238411394;7240.420766338786;7248.0939882514685;7739.961300193463;7757.495762775401;7778.727744528915;7792.181820908723;7801.9609901950125;7154.39187669054;7208.45936554771;7265.37539936098;7384.446166537424;7432.554046757212;7142.5714457132735;7167.139943206848;7232.276772322936;7253.455990800606;7317.963410182915;6532.183477065367;6706.228783689743;6918.342757438036;7021.262767409348;7023.438124950094;6510.902336464862;6513.348665133449;6530.346965303622;6544.116544266653;6584.209894812653;6495.350464953467;6642.667866606747;6654.434373078343;6709.530332876652;6718.764843230463 16:19:04 INFO - 2015-11-15 16:19:04,903 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.18703241895264;330.94870295104255;333.43815670595035;337.989860304191;337.99831000844995;6168.383161683835;6170.907436388457;6217.813465596028;6245.718942647581;6250.499960003201;5844.1818145459665;5967.910481342772;5990.820275391745;6083.20918280624;6099.3290738018895;4648.372469716587;4681.297805329211;4685.1332503486965;4687.765611719417;4700.952990470103;4430.335449682541;4682.08699303636;4690.90618187636;4697.248440249561;4699.67102302839;4470.128324976631;4516.345129956155;4594.2419500782335;4629;4646.814127434898;4585.243434833248;4612.423447069116;4617.5151609080895;4635.119327327797;4636.304554316863;4050.5746896576024;4056.898577535556;4059.776712280823;4060.796960151981;4066.654334381581;5591.888162236733;5716.371199168088;5719.885602287931;5722.313322401338;5727.4845263926445;5278.604104692164;5314.681119132864;5331.493508116722;5332.3601167859715;5347.197920311945;6516.77191298307;6524.151860258184;6528.608283503005;6530.771423000172;6534.50991175659;4391.3193455014525;4393.824247030147;4398.912021759579;4399.758013309267;4406.515283318832;6595.175603049619;6656.633885136315;6675.0988616537115;6720.966395168041;6732.4950628703045;4546.840860569864;4549.522300158502;4550.817967281272;4552.180607490617;4559.224931761542;4611.354410382549;4613.63090952723;4616.76916154191;4617.907641847144;4619.838305659353;5352.2506849041165;5358.223057656696;5369.624126311199;5372.946270537323;5377.4084850666395;6420.26166990802;6543.967280163569;6546.476281897437;6554.80335589933;6557.672116394161;1601.8558329750379;1613.6288653609502;1624.4395683489176;1626.203160451394;1627.3165270586146;1061.596593294543;1068.941208233539;1074.940878251688;1078.8597482327248;1089.2103225161695;6330.4619107375465;6348.904766428507;6356.45970092538;6363.236411630542;6366.618002919747;6525.771597994142;6776.69504872282;6777.728890844311;6779.322067793181;6790.7623233186605;6202.937970620236;6204.5967012144065;6397.136386587844;6398.840028999312;6407.359264073649;3646.0520264731363;3683.9447408288897;3694.2980833641523;3701.759385639925;3704.6110158432975;6958.234594194634;7062.646867656596;7062.788116356517;7066.823329416703;7074.893876591856;6908.48013437043;6908.896366554506;6911.75808846688;6915.654217289115;6922.446204303644;7076.044733960953;7092.468064895051;7101.644917754092;7104.3250891164225;7104.751333703295;6662.866742665216;6803.115594972622;6858.828529286808;6864.519483636098;6876.793696189123;6760.053592497153;6780.355866192704;6785.287544807921;6787.355201255873;6791.93208067913;7051.942208668741;7064.258252883374;7080.893786593102;7088.220295767358;7093.787186384417;4415.381846541551;4512.9774351128035;4562.1788078146255;4594.264917613166;4595.977020114878;6699.665016749045;6704.094947182263;6739;6747.696353663999;6766.458683305422;6575.835604109744;6580.5722628029025;6581.506387020897;6588.703508342041;6602.438792702674;6436;6564;6573.244076931214;6577.539572229898;6582.572132811352;6433.228012638513;6443.194600674916;6451;6452.870942581028;6459.61242325462;6569.868602628017;6608.107905432705;6614.074029635759;6616.305287944889;6627.602343859384;6288.905666414916;6314.305426403;6414.903776443451;6445.452136568257;6448.258450278278 16:19:04 INFO - 2015-11-15 16:19:04,904 DEBUG : BROWSER_OUTPUT: |5;yui.html;711.1146622455041;723.7177500774698;778.4434129597337;793.5757207648998;854.51292763125;10659.573617055317;10769.246152769309;10824.40465774382;10830.620928267512;10849.837252441219;12393.256404615708;13508.662283442918;13679.658008549766;13973.580792576238;13984.65038374041;811.0632219786156;836.4939211776848;836.9707060252892;837.6398148796015;838.0822998816286;833.6665333866472;848.5545088828353;849.4266370200121;849.8512760266929;849.9915000850006;870.0690261420283;887.6671248281895;888.0630934364243;889.1952782731638;889.4485419040171;869.4522450855952;880.8634661627458;881.5239770523941;882.7748924024365;882.8101958078979;643.404850513278;643.7875501084677;643.7939859245043;648.4552975500602;650.5836264790538;13040.478380864753;13140.211587304791;13165.078444508888;13273.734525309535;13307.667308317272;11996.400179990966;12083.395830208454;12227.572034978733;12341.444634991447;12595.748085038247;10317.690469285933;10433.113185379252;10446.373217606968;10533.525991330409;10649.680509584725;3544.9113772155642;3547.8048707321086;3596.868398160805;3616.9276614467562;3617.149969757105;41473;41558.79220603908;44475;45280.3207951881;49511.75244123792;7352.852942941111;7587.165411804697;7609.162992070867;7622.199669034671;9039.502827344559;12940.09419340637;13067.085304028817;13074.150180238254;13090.803637945439;13098.541551045859;6028.909566356509;6871.622060786604;6960.37356637905;7068.858622827514;7240.52936559122;4209.810558524874;4239.448871646728;4305.806238719265;4312.935305970413;4404.801783919731;2799.958000629992;2806.9859650701615;2845.886164553436;2848.529992551206;2857.399946011361;454.9044700612842;463.6082510278809;465.27417229122676;469.01740852913093;473.91469535483253;569.7493103034651;573.1284085275161;582.347770497046;594.8899453601098;617.4998251416367;7959.283664470109;8509.106543812934;8649;8791.5164665944;8885.733427997171;553.6235359955189;587.9088741245114;605.352273067822;611.2664802237244;621.9440250377488;3836.8081595920094;4010.7192496525545;4028.053407449247;4192.24539582878;4221.134667393177;58752.70623646854;60695.39304606897;61137;61195;61254.38745612487;52557;53212;53702.462975369745;53707.19439208415;53754;45467.09065818665;45906;46099.30851037237;46549.767251163525;50029.249561255885;8266.793330166794;8305.37709671765;8538.146185381413;8712.21590056898;8773.780655483664;31819.20451988719;33261.33477330488;37119;37589.248215035;38125.80937095297;49576.256356153965;49765;50333.49666503435;50911;50992;7518.28576285252;7836.84326313482;7843.333316668147;7850.803729906798;7938.722144724907;11041.72395690082;11534.653960381202;11760.941195293968;11772.117091218364;11837.171398002058;9906.851397228904;9924.40453572788;10268.845967310646;10298.845517317097;10405.843912341472;10455.653179305944;10729.517171727448;10758;10790.406527641055;10889.455527223765;9102.544872756203;9227.3079519035;9257.814843703223;9683.806323873343;10273.434961077213;8653.961524617087;9363.578638961399;9488.715338539854;9639.867043210845;9745.756356091155;8699.521526316114;8810;8823.823523529365;9276.860847087433;9407.623695052122 16:19:04 INFO - 2015-11-15 16:19:04,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,881 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1447633144894__endTimestamp 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:19:04 INFO - 2015-11-15 16:19:04,905 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,906 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5475.81 Median:5656.77 stddev:625.91 (11.1%) stddev-sans-first:601.47 16:19:04 INFO - 2015-11-15 16:19:04,906 DEBUG : BROWSER_OUTPUT: Values: 3184.5 3253.3 3293.7 3301.2 3307.3 5250.0 5377.1 5389.4 5395.0 5409.5 5407.8 5499.5 5522.8 5568.3 5577.1 4704.7 4986.3 5019.3 5030.8 5062.5 5100.9 5105.2 5159.8 5169.0 5173.5 4782.6 4872.7 4877.5 5004.1 5032.1 4972.1 4985.8 4989.0 4995.1 5038.9 4956.6 4979.5 4990.5 4990.6 5038.8 5069.6 5180.0 5203.3 5274.9 5320.7 5995.4 6007.3 6008.0 6009.2 6018.1 5873.5 6035.8 6036.7 6037.3 6043.1 5460.9 5517.0 5538.0 5567.8 5602.2 6007.8 6014.2 6020.3 6029.0 6069.8 5741.2 5846.1 5851.9 5889.1 5890.5 5798.1 5838.4 5838.9 5840.2 5920.9 5889.4 5905.6 5918.9 5921.6 5922.8 5696.7 5751.2 5817.2 5907.2 5919.1 4525.5 4554.8 4558.6 4568.6 4600.6 4044.1 4049.5 4069.3 4070.7 4100.1 5361.0 5468.8 5474.2 5564.9 5724.1 5885.6 5902.2 5903.0 5908.5 5940.0 5583.2 5589.5 5599.5 5600.3 5603.4 4950.6 5000.1 5038.7 5045.2 5082.1 6143.1 6279.2 6283.4 6292.9 6298.9 6002.2 6027.8 6043.7 6047.8 6062.9 5962.3 6007.6 6066.7 6074.3 6249.8 5846.0 5858.0 5885.2 5897.9 5914.1 5955.0 5963.4 5976.9 5978.5 5984.2 5503.7 5601.6 5643.5 5762.6 5836.6 5625.1 5768.8 5769.5 5778.1 5789.1 5613.2 5677.9 5682.1 5699.0 5704.9 5518.5 5623.1 5642.6 5656.8 5672.5 5674.3 5726.1 5741.7 5746.9 5781.8 16:19:04 INFO - 2015-11-15 16:19:04,906 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,906 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47829.67 Median:18132.13 stddev:77879.25 (429.5%) stddev-sans-first:78016.89 16:19:04 INFO - 2015-11-15 16:19:04,907 DEBUG : BROWSER_OUTPUT: Values: 571.1 584.2 591.3 603.9 605.9 32553.8 33491.5 33541.5 41216.8 41431.8 44246.1 44791.0 44961.8 45016.3 45021.3 8608.8 8715.3 8745.8 8767.2 8771.7 7857.8 8067.1 10408.3 10660.9 10686.1 10368.1 10432.0 10434.2 10498.9 10511.9 7871.1 8072.1 10310.3 10319.4 10450.2 10391.7 10665.8 10678.9 10679.9 10688.3 41852.4 42379.6 42405.6 42457.0 42489.0 3202.8 3222.9 3303.8 3318.2 3676.5 30645.8 31050.0 31460.0 31705.0 32391.4 3069.2 3094.3 3295.1 3386.8 3427.1 294807.0 295515.0 296699.0 297622.6 298387.0 58927.0 60595.7 63196.7 63321.4 63735.7 67204.7 67848.0 68200.7 68245.0 68255.0 15077.5 15294.5 15397.1 15442.8 15489.6 10662.6 10811.6 10825.1 10836.2 10837.6 20049.0 20462.2 20675.5 20719.5 20754.1 8267.8 8300.8 8309.0 8403.7 8418.3 923.2 940.0 1027.9 1051.9 1143.2 28354.3 28841.1 29097.7 29184.7 29200.3 979.4 999.5 1035.8 1117.5 1132.4 15136.9 15185.5 15262.0 15412.7 15433.8 324210.0 327061.0 327457.0 327763.0 328056.0 53152.8 53628.7 53674.7 53695.7 53704.7 1221.8 1273.9 1282.3 1341.5 1344.4 26940.7 28064.6 28529.7 28720.3 29110.6 48427.5 48828.5 48903.5 49013.0 49215.5 265747.0 267339.0 268384.0 269936.0 270026.0 32969.2 33580.2 33822.7 33848.5 33869.3 44122.3 44467.6 44582.8 45315.3 45789.3 37114.8 37876.4 37895.4 38517.8 38548.6 32309.4 36943.6 37870.0 40200.6 43474.0 40564.0 41049.8 41126.2 41276.2 41457.8 32042.4 32218.0 34593.3 34912.7 36321.6 25831.4 25991.4 26141.5 26320.3 26546.2 16:19:04 INFO - 2015-11-15 16:19:04,907 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,908 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27962.62 Median:44234.45 stddev:88707.03 (200.5%) stddev-sans-first:88931.63 16:19:04 INFO - 2015-11-15 16:19:04,908 DEBUG : BROWSER_OUTPUT: Values: 343.4 343.8 344.0 344.4 346.6 14789.6 14845.7 16877.7 17495.5 18938.3 15977.5 16910.6 17256.0 17557.4 17611.7 5316.1 5442.9 5453.1 5460.1 5460.9 3855.7 3967.3 5401.6 5441.8 5749.9 5895.5 5907.6 5914.7 5920.5 5935.6 5812.2 5925.8 5926.6 5928.3 5935.4 5072.0 5096.2 5137.2 5144.9 5154.6 19906.9 20385.0 20553.9 20608.7 20622.9 2147.9 2294.4 2351.6 2364.8 2372.0 13212.1 13358.3 13478.8 13506.4 13779.7 1771.5 1804.4 1814.4 1826.7 1843.5 58282.7 60045.7 60210.4 60526.0 61033.2 9112.4 9324.7 9661.0 9761.0 9820.7 12433.8 12438.8 12439.4 12443.8 12458.9 7255.9 7481.7 7485.3 7492.2 7573.4 7384.6 7426.1 7477.0 7485.8 7530.7 5746.4 5901.2 5935.2 5936.9 5947.3 1593.3 1629.4 1673.3 1673.9 1675.8 904.3 915.7 985.3 1028.7 1036.5 16662.2 17287.5 17291.7 17475.7 17667.1 894.3 932.0 934.8 954.0 977.5 10308.9 10419.3 10470.7 10493.6 10525.6 525925.0 525993.0 526658.0 548057.0 585061.0 67310.0 75926.6 76741.0 76845.8 78001.0 536.4 547.2 548.3 549.1 550.0 10869.5 11219.1 11359.9 11422.8 11457.7 20301.3 33778.0 34078.5 36035.0 37131.6 42475.8 43785.3 44118.6 44350.3 44909.3 6517.9 6556.0 6646.1 6648.3 6671.9 12429.7 12524.6 12538.9 12699.6 12715.9 9341.6 9640.0 9857.5 11115.1 11294.3 10804.9 10808.4 10824.2 11036.1 11152.2 9380.7 9691.6 10793.9 10923.5 11062.1 6530.9 6615.5 6618.4 6618.5 6636.3 9414.4 10703.8 10930.2 11135.4 11144.4 16:19:04 INFO - 2015-11-15 16:19:04,908 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,908 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5527.41 Median:6564.16 stddev:2858.73 (43.6%) stddev-sans-first:2849.88 16:19:04 INFO - 2015-11-15 16:19:04,909 DEBUG : BROWSER_OUTPUT: Values: 1395.8 1711.9 1768.0 1779.7 1804.8 6862.8 7490.8 7627.2 7632.6 7639.5 7735.1 7827.8 7845.6 7849.1 7857.1 1997.8 2072.5 2285.6 2307.1 2321.4 2340.3 2340.9 2344.2 2347.5 2351.0 2251.3 2286.2 2290.2 2290.6 2293.6 2022.9 2067.4 2265.5 2298.2 2301.4 2287.4 2310.3 2348.9 2352.5 2357.5 7819.3 7900.7 7904.0 7904.8 7932.6 4752.3 4842.5 4845.4 4860.4 4884.0 3136.3 3141.9 3178.8 3198.9 3275.0 961.3 965.9 966.5 991.3 1012.7 10906.9 10910.0 10916.7 10918.8 10943.5 4294.8 4354.3 4403.8 4418.9 4436.8 9373.3 9399.9 9405.9 9411.0 9415.2 4802.2 4840.2 4840.4 4847.1 4851.2 4359.9 4428.4 4432.2 4434.3 4435.7 3725.6 3741.7 3774.5 3801.3 3820.7 1224.2 1227.5 1229.3 1236.7 1238.0 981.6 1009.6 1037.5 1038.7 1068.7 7162.0 7230.1 7264.2 7288.5 7302.9 1096.9 1117.0 1118.8 1120.0 1129.1 5539.5 5626.0 5630.6 5633.7 5644.4 9103.1 9179.8 9530.2 9622.3 9649.0 9333.8 9492.8 9512.2 9523.0 9526.5 6894.8 7026.5 7042.5 7276.5 7321.1 7227.6 7329.9 7332.3 7340.5 7360.9 8165.9 8288.2 8426.8 8430.2 8434.3 8502.3 8662.0 8678.4 8693.6 8705.2 6996.6 7197.1 7230.1 7240.4 7248.1 7740.0 7757.5 7778.7 7792.2 7802.0 7154.4 7208.5 7265.4 7384.4 7432.6 7142.6 7167.1 7232.3 7253.5 7318.0 6532.2 6706.2 6918.3 7021.3 7023.4 6510.9 6513.3 6530.3 6544.1 6584.2 6495.4 6642.7 6654.4 6709.5 6718.8 16:19:04 INFO - 2015-11-15 16:19:04,909 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5448.11 Median:6248.11 stddev:1673.72 (26.8%) stddev-sans-first:1633.65 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: Values: 325.2 330.9 333.4 338.0 338.0 6168.4 6170.9 6217.8 6245.7 6250.5 5844.2 5967.9 5990.8 6083.2 6099.3 4648.4 4681.3 4685.1 4687.8 4701.0 4430.3 4682.1 4690.9 4697.2 4699.7 4470.1 4516.3 4594.2 4629.0 4646.8 4585.2 4612.4 4617.5 4635.1 4636.3 4050.6 4056.9 4059.8 4060.8 4066.7 5591.9 5716.4 5719.9 5722.3 5727.5 5278.6 5314.7 5331.5 5332.4 5347.2 6516.8 6524.2 6528.6 6530.8 6534.5 4391.3 4393.8 4398.9 4399.8 4406.5 6595.2 6656.6 6675.1 6721.0 6732.5 4546.8 4549.5 4550.8 4552.2 4559.2 4611.4 4613.6 4616.8 4617.9 4619.8 5352.3 5358.2 5369.6 5372.9 5377.4 6420.3 6544.0 6546.5 6554.8 6557.7 1601.9 1613.6 1624.4 1626.2 1627.3 1061.6 1068.9 1074.9 1078.9 1089.2 6330.5 6348.9 6356.5 6363.2 6366.6 6525.8 6776.7 6777.7 6779.3 6790.8 6202.9 6204.6 6397.1 6398.8 6407.4 3646.1 3683.9 3694.3 3701.8 3704.6 6958.2 7062.6 7062.8 7066.8 7074.9 6908.5 6908.9 6911.8 6915.7 6922.4 7076.0 7092.5 7101.6 7104.3 7104.8 6662.9 6803.1 6858.8 6864.5 6876.8 6760.1 6780.4 6785.3 6787.4 6791.9 7051.9 7064.3 7080.9 7088.2 7093.8 4415.4 4513.0 4562.2 4594.3 4596.0 6699.7 6704.1 6739.0 6747.7 6766.5 6575.8 6580.6 6581.5 6588.7 6602.4 6436.0 6564.0 6573.2 6577.5 6582.6 6433.2 6443.2 6451.0 6452.9 6459.6 6569.9 6608.1 6614.1 6616.3 6627.6 6288.9 6314.3 6414.9 6445.5 6448.3 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13489.38 Median:53457.23 stddev:16587.14 (31.0%) stddev-sans-first:16605.91 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: Values: 711.1 723.7 778.4 793.6 854.5 10659.6 10769.2 10824.4 10830.6 10849.8 12393.3 13508.7 13679.7 13973.6 13984.7 811.1 836.5 837.0 837.6 838.1 833.7 848.6 849.4 849.9 850.0 870.1 887.7 888.1 889.2 889.4 869.5 880.9 881.5 882.8 882.8 643.4 643.8 643.8 648.5 650.6 13040.5 13140.2 13165.1 13273.7 13307.7 11996.4 12083.4 12227.6 12341.4 12595.7 10317.7 10433.1 10446.4 10533.5 10649.7 3544.9 3547.8 3596.9 3616.9 3617.1 41473.0 41558.8 44475.0 45280.3 49511.8 7352.9 7587.2 7609.2 7622.2 9039.5 12940.1 13067.1 13074.2 13090.8 13098.5 6028.9 6871.6 6960.4 7068.9 7240.5 4209.8 4239.4 4305.8 4312.9 4404.8 2800.0 2807.0 2845.9 2848.5 2857.4 454.9 463.6 465.3 469.0 473.9 569.7 573.1 582.3 594.9 617.5 7959.3 8509.1 8649.0 8791.5 8885.7 553.6 587.9 605.4 611.3 621.9 3836.8 4010.7 4028.1 4192.2 4221.1 58752.7 60695.4 61137.0 61195.0 61254.4 52557.0 53212.0 53702.5 53707.2 53754.0 45467.1 45906.0 46099.3 46549.8 50029.2 8266.8 8305.4 8538.1 8712.2 8773.8 31819.2 33261.3 37119.0 37589.2 38125.8 49576.3 49765.0 50333.5 50911.0 50992.0 7518.3 7836.8 7843.3 7850.8 7938.7 11041.7 11534.7 11760.9 11772.1 11837.2 9906.9 9924.4 10268.8 10298.8 10405.8 10455.7 10729.5 10758.0 10790.4 10889.5 9102.5 9227.3 9257.8 9683.8 10273.4 8654.0 9363.6 9488.7 9639.9 9745.8 8699.5 8810.0 8823.8 9276.9 9407.6 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:19:04 INFO - 2015-11-15 16:19:04,910 DEBUG : BROWSER_OUTPUT: 16:19:05 INFO - 2015-11-15 16:19:05,669 INFO : Browser exited with error code: 0 16:19:05 INFO - 2015-11-15 16:19:05,688 INFO : Completed test dromaeo_css (00:18:37) 16:19:05 INFO - 2015-11-15 16:19:05,688 INFO : Starting test kraken 16:19:05 INFO - 2015-11-15 16:19:05,688 DEBUG : operating with platform_type : linux_ 16:19:05 INFO - 2015-11-15 16:19:05,688 INFO : Initialising browser for kraken test... 16:19:05 INFO - 2015-11-15 16:19:05,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1BVxiY/profile http://localhost:55241/getInfo.html 16:19:09 INFO - 2015-11-15 16:19:09,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:19:09 INFO - 2015-11-15 16:19:09,757 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:19:09 INFO - 2015-11-15 16:19:09,757 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:19:09 INFO - 2015-11-15 16:19:09,757 DEBUG : BROWSER_OUTPUT: __metrics 16:19:09 INFO - 2015-11-15 16:19:09,885 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:11 INFO - 2015-11-15 16:19:11,314 INFO : Browser initialized. 16:19:11 INFO - 2015-11-15 16:19:11,315 INFO : Running cycle 1/1 for kraken test... 16:19:11 INFO - 2015-11-15 16:19:11,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1BVxiY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:19:23 INFO - 2015-11-15 16:19:23,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 16:19:23 INFO - 2015-11-15 16:19:23,052 DEBUG : BROWSER_OUTPUT: 16:19:25 INFO - 2015-11-15 16:19:25,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55241/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:26 INFO - 2015-11-15 16:19:26,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 177422336 16:19:26 INFO - 2015-11-15 16:19:26,097 DEBUG : BROWSER_OUTPUT: 16:19:28 INFO - 2015-11-15 16:19:28,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55241/tests/kraken/driver.html?testName=audio-dft) 16:19:29 INFO - 2015-11-15 16:19:29,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 166932480 16:19:29 INFO - 2015-11-15 16:19:29,280 DEBUG : BROWSER_OUTPUT: 16:19:32 INFO - 2015-11-15 16:19:32,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55241/tests/kraken/driver.html?testName=audio-fft) 16:19:32 INFO - 2015-11-15 16:19:32,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 150253568 16:19:32 INFO - 2015-11-15 16:19:32,691 DEBUG : BROWSER_OUTPUT: 16:19:34 INFO - 2015-11-15 16:19:34,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55241/tests/kraken/driver.html?testName=audio-oscillator) 16:19:35 INFO - 2015-11-15 16:19:35,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 152875008 16:19:35 INFO - 2015-11-15 16:19:35,217 DEBUG : BROWSER_OUTPUT: 16:19:37 INFO - 2015-11-15 16:19:37,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:37 INFO - 2015-11-15 16:19:37,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 154959872 16:19:37 INFO - 2015-11-15 16:19:37,928 DEBUG : BROWSER_OUTPUT: 16:19:40 INFO - 2015-11-15 16:19:40,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55241/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:41 INFO - 2015-11-15 16:19:41,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 154075136 16:19:41 INFO - 2015-11-15 16:19:41,426 DEBUG : BROWSER_OUTPUT: 16:19:44 INFO - 2015-11-15 16:19:44,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55241/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:45 INFO - 2015-11-15 16:19:45,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 155279360 16:19:45 INFO - 2015-11-15 16:19:45,447 DEBUG : BROWSER_OUTPUT: 16:19:48 INFO - 2015-11-15 16:19:48,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55241/tests/kraken/driver.html?testName=json-parse-financial) 16:19:48 INFO - 2015-11-15 16:19:48,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 157261824 16:19:48 INFO - 2015-11-15 16:19:48,763 DEBUG : BROWSER_OUTPUT: 16:19:50 INFO - 2015-11-15 16:19:50,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:50 INFO - 2015-11-15 16:19:50,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 165847040 16:19:50 INFO - 2015-11-15 16:19:50,898 DEBUG : BROWSER_OUTPUT: 16:19:52 INFO - 2015-11-15 16:19:52,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:53 INFO - 2015-11-15 16:19:53,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 165380096 16:19:53 INFO - 2015-11-15 16:19:53,257 DEBUG : BROWSER_OUTPUT: 16:19:55 INFO - 2015-11-15 16:19:55,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:55 INFO - 2015-11-15 16:19:55,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 176558080 16:19:55 INFO - 2015-11-15 16:19:55,867 DEBUG : BROWSER_OUTPUT: 16:19:58 INFO - 2015-11-15 16:19:58,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:59 INFO - 2015-11-15 16:19:59,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 181395456 16:19:59 INFO - 2015-11-15 16:19:59,278 DEBUG : BROWSER_OUTPUT: 16:20:01 INFO - 2015-11-15 16:20:01,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:02 INFO - 2015-11-15 16:20:02,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 179564544 16:20:02 INFO - 2015-11-15 16:20:02,394 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55241/tests/kraken/driver.html?testName=ai-astar) 16:20:04 INFO - 2015-11-15 16:20:04,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 238948352 16:20:04 INFO - 2015-11-15 16:20:04,297 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,298 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:20:04 INFO - 2015-11-15 16:20:04,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:20:04 INFO - 2015-11-15 16:20:04,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:20:04 INFO - 2015-11-15 16:20:04,298 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:20:04 INFO - 2015-11-15 16:20:04,299 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;103;108;109;110;99;109;100;109 16:20:04 INFO - 2015-11-15 16:20:04,299 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;125;153;161;125;152;162;126;171;124 16:20:04 INFO - 2015-11-15 16:20:04,299 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;158;161;161;158;161;159;162;160;161 16:20:04 INFO - 2015-11-15 16:20:04,299 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;82;92;72;71;72;111;90;72 16:20:04 INFO - 2015-11-15 16:20:04,300 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;136;91;89;89;132;89;89;132 16:20:04 INFO - 2015-11-15 16:20:04,300 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;109;109;109;109;109;109;110 16:20:04 INFO - 2015-11-15 16:20:04,300 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;146;146;146;146;145;146 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;96;96;95;95;95 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;61;60;60;60;61;68;57;59 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;66;66;67;66;66;65;66;66 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;86;91;85;84;84;87;87 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;120;114;115;122;123;114;121;131 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;136;150;151;148;135;158;154;146;140 16:20:04 INFO - 2015-11-15 16:20:04,301 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;65;69;64;64;65;66;65 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,919 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: __startTimestamp1447633204296__endTimestamp 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:20:04 INFO - 2015-11-15 16:20:04,302 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:20:04 INFO - 2015-11-15 16:20:04,303 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,303 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:4.25 (3.9%) stddev-sans-first:4.32 16:20:04 INFO - 2015-11-15 16:20:04,303 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 103.0 108.0 109.0 110.0 99.0 109.0 100.0 109.0 16:20:04 INFO - 2015-11-15 16:20:04,304 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,304 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:152.50 stddev:18.07 (11.8%) stddev-sans-first:19.14 16:20:04 INFO - 2015-11-15 16:20:04,304 DEBUG : BROWSER_OUTPUT: Values: 147.0 125.0 153.0 161.0 125.0 152.0 162.0 126.0 171.0 124.0 16:20:04 INFO - 2015-11-15 16:20:04,304 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: Values: 161.0 158.0 161.0 161.0 158.0 161.0 159.0 162.0 160.0 161.0 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:13.36 (18.6%) stddev-sans-first:13.80 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 82.0 92.0 72.0 71.0 72.0 111.0 90.0 72.0 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:89.00 stddev:21.11 (23.7%) stddev-sans-first:21.88 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 136.0 91.0 89.0 89.0 132.0 89.0 89.0 132.0 16:20:04 INFO - 2015-11-15 16:20:04,305 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.33 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 16:20:04 INFO - 2015-11-15 16:20:04,306 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:2.84 (4.7%) stddev-sans-first:3.00 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 61.0 60.0 60.0 60.0 61.0 68.0 57.0 59.0 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 66.0 67.0 66.0 66.0 65.0 66.0 66.0 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.26 (2.6%) stddev-sans-first:2.18 16:20:04 INFO - 2015-11-15 16:20:04,307 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 86.0 91.0 85.0 84.0 84.0 87.0 87.0 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.50 stddev:5.23 (4.3%) stddev-sans-first:5.55 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 120.0 114.0 115.0 122.0 123.0 114.0 121.0 131.0 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.50 stddev:7.56 (5.1%) stddev-sans-first:7.97 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: Values: 149.0 136.0 150.0 151.0 148.0 135.0 158.0 154.0 146.0 140.0 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.43 (2.2%) stddev-sans-first:1.51 16:20:04 INFO - 2015-11-15 16:20:04,308 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 65.0 69.0 64.0 64.0 65.0 66.0 65.0 16:20:04 INFO - 2015-11-15 16:20:04,309 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:20:04 INFO - 2015-11-15 16:20:04,309 DEBUG : BROWSER_OUTPUT: 16:20:05 INFO - 2015-11-15 16:20:05,109 INFO : Browser exited with error code: 0 16:20:05 INFO - 2015-11-15 16:20:05,158 INFO : Completed test kraken (00:00:59) 16:20:05 INFO - 2015-11-15 16:20:05,158 INFO : Starting test v8_7 16:20:05 INFO - 2015-11-15 16:20:05,158 DEBUG : operating with platform_type : linux_ 16:20:05 INFO - 2015-11-15 16:20:05,158 INFO : Initialising browser for v8_7 test... 16:20:05 INFO - 2015-11-15 16:20:05,164 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRSk4QK/profile http://localhost:55241/getInfo.html 16:20:09 INFO - 2015-11-15 16:20:09,249 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:20:09 INFO - 2015-11-15 16:20:09,249 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:20:09 INFO - 2015-11-15 16:20:09,249 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:20:09 INFO - 2015-11-15 16:20:09,249 DEBUG : BROWSER_OUTPUT: __metrics 16:20:09 INFO - 2015-11-15 16:20:09,391 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:20:10 INFO - 2015-11-15 16:20:10,884 INFO : Browser initialized. 16:20:10 INFO - 2015-11-15 16:20:10,885 INFO : Running cycle 1/1 for v8_7 test... 16:20:10 INFO - 2015-11-15 16:20:10,885 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRSk4QK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:20:22 INFO - 2015-11-15 16:20:22,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 141393920 16:20:22 INFO - 2015-11-15 16:20:22,626 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55241/tests/v8_7/run.html (next: http://localhost:55241/tests/v8_7/run.html) 16:20:44 INFO - 2015-11-15 16:20:44,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 604008448 16:20:44 INFO - 2015-11-15 16:20:44,349 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: |0;Richards;170.56114617090228 16:20:44 INFO - 2015-11-15 16:20:44,350 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.4984520123839 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.1230329041488 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 16:20:44 INFO - 2015-11-15 16:20:44,351 DEBUG : BROWSER_OUTPUT: |8;Splay;630.6924516531503 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: __startTimestamp1447633244349__endTimestamp 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,352 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.56 Median:170.56 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: Values: 170.6 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.50 Median:193.50 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: Values: 193.5 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.12 Median:286.12 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: Values: 286.1 16:20:44 INFO - 2015-11-15 16:20:44,353 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,354 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,354 DEBUG : BROWSER_OUTPUT: Values: 5030.2 16:20:44 INFO - 2015-11-15 16:20:44,354 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,354 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,355 DEBUG : BROWSER_OUTPUT: Values: 1101.3 16:20:44 INFO - 2015-11-15 16:20:44,355 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: Values: 794.3 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: Values: 11988.1 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,356 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: Values: 25846.2 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.69 Median:630.69 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: Values: 630.7 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: Values: 4850.2 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:20:44 INFO - 2015-11-15 16:20:44,357 DEBUG : BROWSER_OUTPUT: 16:20:45 INFO - 2015-11-15 16:20:45,181 INFO : Browser exited with error code: 0 16:20:45 INFO - 2015-11-15 16:20:45,198 INFO : Completed test v8_7 (00:00:40) 16:20:45 INFO - 2015-11-15 16:20:45,308 INFO : Completed test suite (00:20:17) 16:20:45 INFO - 2015-11-15 16:20:45,308 DEBUG : Working with test: dromaeo_css 16:20:45 INFO - 2015-11-15 16:20:45,308 DEBUG : Generating results file: dromaeo_css 16:20:45 INFO - 2015-11-15 16:20:45,309 DEBUG : Working with test: kraken 16:20:45 INFO - 2015-11-15 16:20:45,309 DEBUG : Generating results file: kraken 16:20:45 INFO - 2015-11-15 16:20:45,310 INFO : javascript benchmark 16:20:45 INFO - 2015-11-15 16:20:45,310 DEBUG : Working with test: v8_7 16:20:45 INFO - 2015-11-15 16:20:45,310 DEBUG : Generating results file: v8_7 16:20:45 INFO - 2015-11-15 16:20:45,310 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:20:45 INFO - 2015-11-15 16:20:45,353 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 16:20:45 INFO - 2015-11-15 16:20:45,353 DEBUG : process_Request line: dromaeo_css 6957.79 graph.html#tests=[[72,201,35]] 16:20:45 INFO - 2015-11-15 16:20:45,353 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:20:45 INFO - 2015-11-15 16:20:45,382 DEBUG : process_Request line: kraken 1490.50 graph.html#tests=[[232,201,35]] 16:20:45 INFO - 2015-11-15 16:20:45,382 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:20:45 INFO - 2015-11-15 16:20:45,409 DEBUG : process_Request line: v8_7 20888.33 graph.html#tests=[[230,201,35]] 16:20:45 INFO - 2015-11-15 16:20:45,410 INFO : javascript benchmark 16:20:45 INFO - 2015-11-15 16:20:45,414 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [343.4161924727961, 343.7937237657404, 343.97076248518874, 344.41105709237206, 346.61525706465835, 14789.630259243497, 14845.703085938274, 16877.746833797504, 17495.47513574593, 18938.337158199465, 15977.520674379759, 16910.577235569086, 17256.0, 17557.3854915078, 17611.735823962652, 5316.149416093416, 5442.91835622464, 5453.072977593819, 5460.126379779236, 5460.890782184354, 3855.749376290546, 3967.325554655701, 5401.621886467949, 5441.782328706847, 5749.856253593652, 5895.528357731371, 5907.556933230004, 5914.674692891889, 5920.526357891358, 5935.554833387491, 5812.186293918855, 5925.792597259076, 5926.614770039933, 5928.340064781868, 5935.406459354073, 5072.036313100499, 5096.210087436453, 5137.178051511778, 5144.871378215575, 5154.613403994716, 19906.900465497725, 20385.0, 20553.89723051375, 20608.69086963697, 20622.896885515478, 2147.881866497342, 2294.4149241943364, 2351.6237402015595, 2364.810815134785, 2371.9525609487887, 13212.075154739172, 13358.265295408748, 13478.797818032639, 13506.392212350467, 13779.724405511834, 1771.5482551949171, 1804.4135655911882, 1814.4103166470818, 1826.6529359421668, 1843.4930394141584, 58282.7085864568, 60045.69977150086, 60210.39789602092, 60526.0, 61033.20184582502, 9112.362134650644, 9324.689735144062, 9660.95169524162, 9760.951195243979, 9820.705378838646, 12433.813492797615, 12438.751224975631, 12439.37803109859, 12443.751124977449, 12458.875411245772, 7255.854882902312, 7481.738139165103, 7485.251474852471, 7492.175860655324, 7573.35626471745, 7384.556926584422, 7426.14599321085, 7477.0, 7485.812854678677, 7530.736424225126, 5746.367899531048, 5901.232839730894, 5935.169076329317, 5936.910946335808, 5947.345791962967, 1593.2989484626728, 1629.3645478263486, 1673.313941284092, 1673.8577220936113, 1675.7570152327844, 904.2991681446931, 915.6520522201521, 985.3201291109111, 1028.7376718936623, 1036.4713995862164, 16662.166891655368, 17287.481375558753, 17291.74062389065, 17475.737863932052, 17667.116644167996, 894.3203165594196, 931.9767005824908, 934.8457504511815, 953.9935368186491, 977.4965892565334, 10308.948455257825, 10419.322744021614, 10470.685879423629, 10493.580256789643, 10525.631602893862, 525925.0, 525993.0, 526658.0, 548057.0, 585061.0, 67310.0, 75926.62036689781, 76741.0, 76845.84731229037, 78001.0, 536.3858382152491, 547.2448021729987, 548.314606741573, 549.1351121982813, 549.9532539734088, 10869.510872010937, 11219.102471802073, 11359.886401135884, 11422.771544569228, 11457.713557161138, 20301.28945486901, 33778.0, 34078.48882266718, 36035.0, 37131.6286837139, 42475.78762106293, 43785.343219852366, 44118.55881441273, 44350.3347449795, 44909.32636010397, 6517.859374609519, 6556.0, 6646.069550263063, 6648.335166483313, 6671.8999215010845, 12429.689257768267, 12524.624261272176, 12538.937305313415, 12699.619011429671, 12715.936420318209, 9341.626334946526, 9639.951800240953, 9857.457839818879, 11115.110791136527, 11294.265872718248, 10804.945975270388, 10808.351498910091, 10824.242303039027, 11036.061934735637, 11152.219344645797, 9380.671676491564, 9691.612335506501, 10793.892061079288, 10923.453827308762, 11062.115030797357, 6530.9020364693615, 6615.470762339098, 6618.371254730793, 6618.536702430976, 6636.2700102987665, 9414.388064776042, 10703.839442408525, 10930.180236482136, 11135.443227838738, 11144.442777860912], "dojo.html": [3184.490481522956, 3253.284277458958, 3293.6706329367066, 3301.1747063234193, 3307.272400071984, 5250.0, 5377.056365456544, 5389.434109418514, 5395.0, 5409.513143817056, 5407.810281738011, 5499.50504454599, 5522.779088836452, 5568.331800183973, 5577.051901176799, 4704.725990823047, 4986.301917731521, 5019.272205530196, 5030.773615187307, 5062.493750624926, 5100.923486147711, 5105.234214867763, 5159.793608255665, 5168.974155129238, 5173.456787037363, 4782.569568738812, 4872.731999740013, 4877.51224877513, 5004.099262132815, 5032.144535428986, 4972.055309491221, 4985.775640096204, 4989.0, 4995.125852975751, 5038.949610503884, 4956.553910148104, 4979.47715489872, 4990.525900039491, 4990.600751939836, 5038.848834534933, 5069.61977851659, 5180.0157969985585, 5203.323567936144, 5274.894502109974, 5320.654157479751, 5995.400459954013, 6007.339192688801, 6008.008678568031, 6009.2188015557695, 6018.097285407181, 5873.471387575139, 6035.849103772397, 6036.698165091728, 6037.275526936752, 6043.123747056652, 5460.863478413072, 5516.972415137939, 5537.972310138423, 5567.777288908479, 5602.215689803431, 6007.789727359609, 6014.248218972629, 6020.277566692025, 6029.0, 6069.817905462844, 5741.224934633771, 5846.064629659234, 5851.941480585139, 5889.087191485327, 5890.4698577128265, 5798.072308430716, 5838.357780644125, 5838.883222335615, 5840.211571437886, 5920.911186332209, 5889.381614930457, 5905.586608937333, 5918.852028699317, 5921.644701317849, 5922.822315330547, 5696.686682232434, 5751.22358481608, 5817.243758311392, 5907.172995780594, 5919.141724449931, 4525.547445255514, 4554.772261386917, 4558.612517935946, 4568.611668008257, 4600.5629465200755, 4044.1102957349335, 4049.493813273341, 4069.2878746219294, 4070.715049946475, 4100.1184745279315, 5361.0, 5468.7539060742365, 5474.233607294982, 5564.86087847799, 5724.141378793214, 5885.61743486672, 5902.203202567598, 5902.970485147633, 5908.527317814564, 5939.970300148471, 5583.190437386556, 5589.524890384281, 5599.496045355938, 5600.327960644749, 5603.439656034364, 4950.628702847301, 5000.1249781288125, 5038.722870242099, 5045.217991211368, 5082.136036873666, 6143.082036032938, 6279.183706118175, 6283.434490895841, 6292.937070629235, 6298.874022519524, 6002.189704389852, 6027.849303767441, 6043.697815109139, 6047.848803779941, 6062.909056364247, 5962.25471816023, 6007.579469437273, 6066.696665166813, 6074.271087469355, 6249.843753906189, 5845.970770146122, 5858.0, 5885.234919460443, 5897.882042359214, 5914.053751399755, 5954.970225148846, 5963.4334738199805, 5976.880462390641, 5978.461938425563, 5984.19213406202, 5503.697296648723, 5601.6358936668985, 5643.463870932255, 5762.596618236683, 5836.620619659709, 5625.128105143709, 5768.826935191951, 5769.509591684754, 5778.075507918713, 5789.131630255327, 5613.1860880171325, 5677.914831277617, 5682.119271512922, 5698.971505142447, 5704.914426283526, 5518.503334699736, 5623.100303951348, 5642.633228840113, 5656.773729050792, 5672.517835983987, 5674.319081710221, 5726.141078838041, 5741.712914354182, 5746.942530574641, 5781.797637082682], "mootools.html": [1395.8045873577707, 1711.9315227390905, 1768.0, 1779.7063484525054, 1804.7924488683798, 6862.82842928927, 7490.812729681754, 7627.237276272377, 7632.618369081538, 7639.465237433382, 7735.1491335953, 7827.804304892381, 7845.60771961401, 7849.0973538043145, 7857.1357150713375, 1997.8301844343248, 2072.4715197624587, 2285.6000199965024, 2307.0886999635177, 2321.3500219938446, 2340.3213068210284, 2340.918067867625, 2344.167820423742, 2347.530493901218, 2350.976490235101, 2251.3020963501285, 2286.1769762885347, 2290.198430549311, 2290.6220473621916, 2293.575688497625, 2022.8583999120067, 2067.390119914621, 2265.546890621882, 2298.218605674079, 2301.3786277705094, 2287.3595393289906, 2310.295359915225, 2348.894299756515, 2352.4942137440535, 2357.5284943011466, 7819.335356494648, 7900.683972641087, 7904.0, 7904.80237994049, 7932.563708996003, 4752.334673145762, 4842.467328593852, 4845.442774080955, 4860.441049279343, 4884.0, 3136.325689976643, 3141.890033848827, 3178.761592880543, 3198.9360212795614, 3274.950875736866, 961.2598299309562, 965.9420434773936, 966.4536741214072, 991.2516050381987, 1012.6556970630021, 10906.890931090667, 10910.018098371185, 10916.727081823017, 10918.836217456745, 10943.4528273586, 4294.7852607369505, 4354.303311470149, 4403.801828917706, 4418.911621767546, 4436.778161091933, 9373.343865929319, 9399.90600094004, 9405.905940940504, 9410.952945235367, 9415.152636262632, 4802.207635740064, 4840.15297322967, 4840.370751802243, 4847.054824309296, 4851.175300198975, 4359.869203923888, 4428.4243048403505, 4432.246518091933, 4434.312681534368, 4435.689501734848, 3725.590185079639, 3741.7006639468777, 3774.5470543534952, 3801.315763162602, 3820.656140947328, 1224.185916365607, 1227.472186959616, 1229.2685851918095, 1236.7031912340974, 1238.0343332200898, 981.5730157381562, 1009.6213919780082, 1037.4501514197486, 1038.678009816944, 1068.7167900506372, 7162.0, 7230.132384113835, 7264.200937896827, 7288.453365997571, 7302.853942921218, 1096.8903109688968, 1117.0393461622998, 1118.7818375416716, 1120.0423637789572, 1129.0628778114146, 5539.529140023144, 5625.971870140705, 5630.577706672016, 5633.69014704187, 5644.3508996465935, 9103.089691030977, 9179.81640367189, 9530.237580993504, 9622.278329125204, 9648.95175524132, 9333.813323733488, 9492.762680933032, 9512.239020878313, 9522.95238523803, 9526.476043817518, 6894.827629309207, 7026.543274687129, 7042.507024508338, 7276.454265930077, 7321.121465424183, 7227.638618069181, 7329.9267007329245, 7332.340089391981, 7340.522866013692, 7360.852782944418, 8165.918340816515, 8288.21261980111, 8426.831463370821, 8430.199131082538, 8434.325253979545, 8502.319814414708, 8662.0, 8678.392512524062, 8693.608787604699, 8705.173008564176, 6996.6151861648095, 7197.100362454693, 7230.13238411394, 7240.420766338786, 7248.0939882514685, 7739.961300193463, 7757.495762775401, 7778.727744528915, 7792.181820908723, 7801.9609901950125, 7154.39187669054, 7208.45936554771, 7265.37539936098, 7384.446166537424, 7432.554046757212, 7142.5714457132735, 7167.139943206848, 7232.276772322936, 7253.455990800606, 7317.963410182915, 6532.183477065367, 6706.228783689743, 6918.342757438036, 7021.262767409348, 7023.438124950094, 6510.902336464862, 6513.348665133449, 6530.346965303622, 6544.116544266653, 6584.209894812653, 6495.350464953467, 6642.667866606747, 6654.434373078343, 6709.530332876652, 6718.764843230463], "ext.html": [571.0553141793926, 584.1529781816365, 591.2963573347719, 603.9245094363205, 605.9333473317935, 32553.837230813842, 33491.49762753561, 33541.49687754686, 41216.79391603045, 41431.79284103583, 44246.11507769843, 44791.0, 44961.775191124, 45016.3247551287, 45021.32468012982, 8608.827823443544, 8715.259202967723, 8745.825083498326, 8767.167119123706, 8771.692990745325, 7857.8035549111155, 8067.112617612058, 10408.323458975181, 10660.946695266513, 10686.091682207021, 10368.06687398134, 10432.0, 10434.217433692465, 10498.895011049868, 10511.947440262787, 7871.0554733432355, 8072.071711753165, 10310.32982856112, 10319.43243121628, 10450.16398688103, 10391.740206494822, 10665.786684266348, 10678.946605267001, 10679.893201067967, 10688.305260158066, 41852.372214416806, 42379.57620423787, 42405.575944240474, 42457.0, 42489.0, 3202.7758056936023, 3222.8549715262634, 3303.801771893694, 3318.1870441741685, 3676.5036720042986, 30645.846770766228, 31050.0, 31460.0, 31705.0, 32391.352172956646, 3069.2020074780494, 3094.257378229209, 3295.07737833407, 3386.8306584670913, 3427.143214196451, 294807.0, 295515.0, 296699.0, 297622.5832095888, 298387.0, 58927.0, 60595.697021515494, 63196.684016579624, 63321.36678633155, 63735.681321593096, 67204.6639766798, 67848.0, 68200.6589967047, 68245.0, 68255.0, 15077.54767356981, 15294.541163765105, 15397.07617542951, 15442.838002679633, 15489.612759681098, 10662.573497060032, 10811.621593244356, 10825.079868211133, 10836.187285953585, 10837.566497340176, 20049.0, 20462.181512739622, 20675.4831129223, 20719.482012949495, 20754.06606702702, 8267.793305167299, 8300.792480187924, 8309.044459887069, 8403.70587029451, 8418.326533877274, 923.2060428031887, 940.0, 1027.8561001459802, 1051.9053285204368, 1143.17691262291, 28354.2911427216, 28841.11588841099, 29097.709022909923, 29184.708152918625, 29200.26999325034, 979.4368238263028, 999.5352161245056, 1035.7519189376783, 1117.4971262931551, 1132.3602164776876, 15136.924315378352, 15185.468508602145, 15262.0, 15412.691746165237, 15433.84566154324, 324210.0, 327061.0, 327457.0, 327763.0, 328056.0, 53152.82436870973, 53628.73185634047, 53674.7316263424, 53695.731521342925, 53704.73147634237, 1221.7800795856654, 1273.8662440443804, 1282.2691066092425, 1341.4768240386256, 1344.4218985836185, 26940.73059269382, 28064.579031314137, 28529.714702852707, 28720.281992950342, 29110.563341550318, 48427.5157248423, 48828.5117148824, 48903.51096489132, 49013.0, 49215.50784492109, 265747.0, 267339.0, 268384.0, 269936.0, 270026.0, 32969.17577060593, 33580.160495987795, 33822.66177338195, 33848.49227261642, 33869.32261354809, 44122.338164928195, 44467.555324446344, 44582.777086114365, 45315.32027019663, 45789.31316030196, 37114.814425927696, 37876.43185352277, 37895.43156852594, 38517.80741096276, 38548.6145138545, 32309.35381292314, 36943.630563694016, 37870.0, 40200.597994020856, 43474.0, 40564.0, 41049.79475102606, 41126.1774764509, 41276.1744765097, 41457.79271103746, 32042.359152816345, 32218.0, 34593.308133836676, 34912.650873491955, 36321.636783631824, 25831.354216144748, 25991.350216244744, 26141.477170456863, 26320.34199145037, 26546.203613891616], "prototype.html": [325.18703241895264, 330.94870295104255, 333.43815670595035, 337.989860304191, 337.99831000844995, 6168.383161683835, 6170.907436388457, 6217.813465596028, 6245.718942647581, 6250.499960003201, 5844.1818145459665, 5967.910481342772, 5990.820275391745, 6083.20918280624, 6099.3290738018895, 4648.372469716587, 4681.297805329211, 4685.1332503486965, 4687.765611719417, 4700.952990470103, 4430.335449682541, 4682.08699303636, 4690.90618187636, 4697.248440249561, 4699.67102302839, 4470.128324976631, 4516.345129956155, 4594.2419500782335, 4629.0, 4646.814127434898, 4585.243434833248, 4612.423447069116, 4617.5151609080895, 4635.119327327797, 4636.304554316863, 4050.5746896576024, 4056.898577535556, 4059.776712280823, 4060.796960151981, 4066.654334381581, 5591.888162236733, 5716.371199168088, 5719.885602287931, 5722.313322401338, 5727.4845263926445, 5278.604104692164, 5314.681119132864, 5331.493508116722, 5332.3601167859715, 5347.197920311945, 6516.77191298307, 6524.151860258184, 6528.608283503005, 6530.771423000172, 6534.50991175659, 4391.3193455014525, 4393.824247030147, 4398.912021759579, 4399.758013309267, 4406.515283318832, 6595.175603049619, 6656.633885136315, 6675.0988616537115, 6720.966395168041, 6732.4950628703045, 4546.840860569864, 4549.522300158502, 4550.817967281272, 4552.180607490617, 4559.224931761542, 4611.354410382549, 4613.63090952723, 4616.76916154191, 4617.907641847144, 4619.838305659353, 5352.2506849041165, 5358.223057656696, 5369.624126311199, 5372.946270537323, 5377.4084850666395, 6420.26166990802, 6543.967280163569, 6546.476281897437, 6554.80335589933, 6557.672116394161, 1601.8558329750379, 1613.6288653609502, 1624.4395683489176, 1626.203160451394, 1627.3165270586146, 1061.596593294543, 1068.941208233539, 1074.940878251688, 1078.8597482327248, 1089.2103225161695, 6330.4619107375465, 6348.904766428507, 6356.45970092538, 6363.236411630542, 6366.618002919747, 6525.771597994142, 6776.69504872282, 6777.728890844311, 6779.322067793181, 6790.7623233186605, 6202.937970620236, 6204.5967012144065, 6397.136386587844, 6398.840028999312, 6407.359264073649, 3646.0520264731363, 3683.9447408288897, 3694.2980833641523, 3701.759385639925, 3704.6110158432975, 6958.234594194634, 7062.646867656596, 7062.788116356517, 7066.823329416703, 7074.893876591856, 6908.48013437043, 6908.896366554506, 6911.75808846688, 6915.654217289115, 6922.446204303644, 7076.044733960953, 7092.468064895051, 7101.644917754092, 7104.3250891164225, 7104.751333703295, 6662.866742665216, 6803.115594972622, 6858.828529286808, 6864.519483636098, 6876.793696189123, 6760.053592497153, 6780.355866192704, 6785.287544807921, 6787.355201255873, 6791.93208067913, 7051.942208668741, 7064.258252883374, 7080.893786593102, 7088.220295767358, 7093.787186384417, 4415.381846541551, 4512.9774351128035, 4562.1788078146255, 4594.264917613166, 4595.977020114878, 6699.665016749045, 6704.094947182263, 6739.0, 6747.696353663999, 6766.458683305422, 6575.835604109744, 6580.5722628029025, 6581.506387020897, 6588.703508342041, 6602.438792702674, 6436.0, 6564.0, 6573.244076931214, 6577.539572229898, 6582.572132811352, 6433.228012638513, 6443.194600674916, 6451.0, 6452.870942581028, 6459.61242325462, 6569.868602628017, 6608.107905432705, 6614.074029635759, 6616.305287944889, 6627.602343859384, 6288.905666414916, 6314.305426403, 6414.903776443451, 6445.452136568257, 6448.258450278278], "yui.html": [711.1146622455041, 723.7177500774698, 778.4434129597337, 793.5757207648998, 854.51292763125, 10659.573617055317, 10769.246152769309, 10824.40465774382, 10830.620928267512, 10849.837252441219, 12393.256404615708, 13508.662283442918, 13679.658008549766, 13973.580792576238, 13984.65038374041, 811.0632219786156, 836.4939211776848, 836.9707060252892, 837.6398148796015, 838.0822998816286, 833.6665333866472, 848.5545088828353, 849.4266370200121, 849.8512760266929, 849.9915000850006, 870.0690261420283, 887.6671248281895, 888.0630934364243, 889.1952782731638, 889.4485419040171, 869.4522450855952, 880.8634661627458, 881.5239770523941, 882.7748924024365, 882.8101958078979, 643.404850513278, 643.7875501084677, 643.7939859245043, 648.4552975500602, 650.5836264790538, 13040.478380864753, 13140.211587304791, 13165.078444508888, 13273.734525309535, 13307.667308317272, 11996.400179990966, 12083.395830208454, 12227.572034978733, 12341.444634991447, 12595.748085038247, 10317.690469285933, 10433.113185379252, 10446.373217606968, 10533.525991330409, 10649.680509584725, 3544.9113772155642, 3547.8048707321086, 3596.868398160805, 3616.9276614467562, 3617.149969757105, 41473.0, 41558.79220603908, 44475.0, 45280.3207951881, 49511.75244123792, 7352.852942941111, 7587.165411804697, 7609.162992070867, 7622.199669034671, 9039.502827344559, 12940.09419340637, 13067.085304028817, 13074.150180238254, 13090.803637945439, 13098.541551045859, 6028.909566356509, 6871.622060786604, 6960.37356637905, 7068.858622827514, 7240.52936559122, 4209.810558524874, 4239.448871646728, 4305.806238719265, 4312.935305970413, 4404.801783919731, 2799.958000629992, 2806.9859650701615, 2845.886164553436, 2848.529992551206, 2857.399946011361, 454.9044700612842, 463.6082510278809, 465.27417229122676, 469.01740852913093, 473.91469535483253, 569.7493103034651, 573.1284085275161, 582.347770497046, 594.8899453601098, 617.4998251416367, 7959.283664470109, 8509.106543812934, 8649.0, 8791.5164665944, 8885.733427997171, 553.6235359955189, 587.9088741245114, 605.352273067822, 611.2664802237244, 621.9440250377488, 3836.8081595920094, 4010.7192496525545, 4028.053407449247, 4192.24539582878, 4221.134667393177, 58752.70623646854, 60695.39304606897, 61137.0, 61195.0, 61254.38745612487, 52557.0, 53212.0, 53702.462975369745, 53707.19439208415, 53754.0, 45467.09065818665, 45906.0, 46099.30851037237, 46549.767251163525, 50029.249561255885, 8266.793330166794, 8305.37709671765, 8538.146185381413, 8712.21590056898, 8773.780655483664, 31819.20451988719, 33261.33477330488, 37119.0, 37589.248215035, 38125.80937095297, 49576.256356153965, 49765.0, 50333.49666503435, 50911.0, 50992.0, 7518.28576285252, 7836.84326313482, 7843.333316668147, 7850.803729906798, 7938.722144724907, 11041.72395690082, 11534.653960381202, 11760.941195293968, 11772.117091218364, 11837.171398002058, 9906.851397228904, 9924.40453572788, 10268.845967310646, 10298.845517317097, 10405.843912341472, 10455.653179305944, 10729.517171727448, 10758.0, 10790.406527641055, 10889.455527223765, 9102.544872756203, 9227.3079519035, 9257.814843703223, 9683.806323873343, 10273.434961077213, 8653.961524617087, 9363.578638961399, 9488.715338539854, 9639.867043210845, 9745.756356091155, 8699.521526316114, 8810.0, 8823.823523529365, 9276.860847087433, 9407.623695052122]}, "summary": {"lowerIsBetter": false, "suite": 6957.793370457435, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8208.394130981664, "unit": "ms", "value": 8208.394130981664}, "dojo.html": {"lowerIsBetter": false, "filtered": 5434.363206189553, "unit": "ms", "value": 5434.363206189553}, "mootools.html": {"lowerIsBetter": false, "filtered": 4534.568467048695, "unit": "ms", "value": 4534.568467048695}, "ext.html": {"lowerIsBetter": false, "filtered": 19125.160517444816, "unit": "ms", "value": 19125.160517444816}, "prototype.html": {"lowerIsBetter": false, "filtered": 4898.125985238506, "unit": "ms", "value": 4898.125985238506}, "yui.html": {"lowerIsBetter": false, "filtered": 5987.055793118357, "unit": "ms", "value": 5987.055793118357}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447632027, "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": "20151115143002", "branch": "B2G-Inbound", "revision": "4db778666e327b863b1471fa2de5f128a894460c"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 158.0, 161.0, 161.0, 158.0, 161.0, 159.0, 162.0, 160.0, 161.0], "ai-astar": [110.0, 109.0, 103.0, 108.0, 109.0, 110.0, 99.0, 109.0, 100.0, 109.0], "imaging-gaussian-blur": [111.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "audio-beat-detection": [147.0, 125.0, 153.0, 161.0, 125.0, 152.0, 162.0, 126.0, 171.0, 124.0], "json-stringify-tinderbox": [67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "stanford-crypto-pbkdf2": [149.0, 136.0, 150.0, 151.0, 148.0, 135.0, 158.0, 154.0, 146.0, 140.0], "json-parse-financial": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 68.0, 57.0, 59.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 65.0, 65.0, 69.0, 64.0, 64.0, 65.0, 66.0, 65.0], "audio-fft": [72.0, 72.0, 82.0, 92.0, 72.0, 71.0, 72.0, 111.0, 90.0, 72.0], "imaging-darkroom": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "stanford-crypto-ccm": [121.0, 124.0, 120.0, 114.0, 115.0, 122.0, 123.0, 114.0, 121.0, 131.0], "audio-oscillator": [90.0, 91.0, 136.0, 91.0, 89.0, 89.0, 132.0, 89.0, 89.0, 132.0], "stanford-crypto-aes": [83.0, 85.0, 85.0, 86.0, 91.0, 85.0, 84.0, 84.0, 87.0, 87.0], "imaging-desaturate": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1490.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.6, "unit": "ms", "value": 144.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.5, "unit": "ms", "value": 120.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.6, "unit": "ms", "value": 60.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 106.6, "unit": "ms", "value": 106.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.2, "unit": "ms", "value": 160.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.5, "unit": "ms", "value": 65.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.2, "unit": "ms", "value": 66.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447632027, "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": "20151115143002", "branch": "B2G-Inbound", "revision": "4db778666e327b863b1471fa2de5f128a894460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.4984520123839], "Encrypt": [286.1230329041488], "NavierStokes": [4850.241545893719], "Decrypt": [5030.150753768844], "Splay": [630.6924516531503], "Richards": [170.56114617090228], "RegExp": [25846.153846153848], "Earley": [794.2811755361398], "Boyer": [11988.095238095239], "RayTrace": [1101.3215859030836]}, "summary": {"lowerIsBetter": false, "suite": 20888.33005492681, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.6978240000001, "unit": "score", "value": 341.6978240000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 930.302595, "unit": "score", "value": 930.302595}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.9641434262948, "unit": "score", "value": 305.9641434262948}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 129.20877645895155, "unit": "score", "value": 129.20877645895155}, "RegExp": {"lowerIsBetter": false, "filtered": 35.24644345238097, "unit": "score", "value": 35.24644345238097}, "Richards": {"lowerIsBetter": false, "filtered": 206.97562599999998, "unit": "score", "value": 206.97562599999998}, "Earley": {"lowerIsBetter": false, "filtered": 839.0769169999999, "unit": "score", "value": 839.0769169999999}, "Boyer": {"lowerIsBetter": false, "filtered": 55.59373584905661, "unit": "score", "value": 55.59373584905661}, "RayTrace": {"lowerIsBetter": false, "filtered": 671.910012, "unit": "score", "value": 671.910012}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-042"}, "testrun": {"date": 1447632027, "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": "20151115143002", "branch": "B2G-Inbound", "revision": "4db778666e327b863b1471fa2de5f128a894460c"}}] 16:20:45 INFO - RETURN: dromaeo_css: 6957.79 16:20:45 INFO - RETURN: kraken: 1490.50 16:20:45 INFO - RETURN: v8_7: 20888.33 16:20:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20888.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1490.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6957.79"}}} 16:20:45 INFO - Return code: 0 16:20:45 INFO - # TBPL SUCCESS # 16:20:45 INFO - Running post-action listener: _resource_record_post_action 16:20:45 INFO - Running post-run listener: _resource_record_post_run 16:20:46 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10321920; Write bytes: 395546624; Read time: 4104; Write time: 580492 16:20:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 471040; Read time: 0; Write time: 52 16:20:46 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8167424; Write bytes: 395075584; Read time: 3968; Write time: 580440 16:20:46 INFO - Running post-run listener: _upload_blobber_files 16:20:46 INFO - Blob upload gear active. 16:20:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:20:46 INFO - Copying logs to upload dir... 16:20:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.797606 ========= master_lag: -0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-15 16:20:46.565915) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 16:20:46.569337) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009213 build_url: 'https://queue.taskcluster.net/v1/task/cfXAryOnQnewYXg3z4YS3g/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-15 16:20:46.618183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 16:20:46.618508) ========= 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=c402a24d74c70935940d60dd000001de-1447631815.802692-1854400525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 16:20:46.667895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 16:20:46.668287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 16:20:46.668588) ========= ========= Total master_lag: -0.01 =========