builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1447836648.77 results: success (0) buildid: 20151117233002 builduid: 574433165d95413d9bb27273571b560a revision: 7dba29b2ea55f6b26b42046c73b511bb89753934 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.774824) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.775217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.775531) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009129 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.803864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.804147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.860407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.860667) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.910320) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.910585) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.910965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:48.911252) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 00:50:50-- 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% 84.0M=0s 2015-11-18 00:50:50 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111056 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:49.034216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:49.034499) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:49.087028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 00:50:49.087328) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7dba29b2ea55f6b26b42046c73b511bb89753934 --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 7dba29b2ea55f6b26b42046c73b511bb89753934 --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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 00:50:50,247 truncating revision to first 12 chars 2015-11-18 00:50:50,247 Setting DEBUG logging. 2015-11-18 00:50:50,247 attempt 1/10 2015-11-18 00:50:50,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7dba29b2ea55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 00:50:51,491 unpacking tar archive at: b2g-inbound-7dba29b2ea55/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 00:50:50.616973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:50.617293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:50.627121) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:50.627378) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:50:50.627785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 00:50:50.628081) ========= /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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:50:51 INFO - MultiFileLogger online at 20151118 00:50:51 in /builds/slave/test-pgo 00:50:51 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 00:50:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:50:51 INFO - {'append_to_log': False, 00:50:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:50:51 INFO - 'blob_upload_branch': 'B2G-Inbound', 00:50:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:50:51 INFO - 'branch': 'B2G-Inbound', 00:50:51 INFO - 'buildbot_json_path': 'buildprops.json', 00:50:51 INFO - 'config_files': ('talos/linux_config.py',), 00:50:51 INFO - 'default_actions': ('clobber', 00:50:51 INFO - 'read-buildbot-config', 00:50:51 INFO - 'download-and-extract', 00:50:51 INFO - 'populate-webroot', 00:50:51 INFO - 'create-virtualenv', 00:50:51 INFO - 'install', 00:50:51 INFO - 'run-tests'), 00:50:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:50:51 INFO - 'download_minidump_stackwalk': True, 00:50:51 INFO - 'download_symbols': 'ondemand', 00:50:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:50:51 INFO - 'tooltool.py': '/tools/tooltool.py', 00:50:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:50:51 INFO - '/tools/misc-python/virtualenv.py')}, 00:50:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:50:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:50:51 INFO - 'installer_path': 'installer.exe', 00:50:51 INFO - 'log_level': 'info', 00:50:51 INFO - 'log_name': 'talos', 00:50:51 INFO - 'log_to_console': True, 00:50:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:50:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:50:51 INFO - 'opt_config_files': (), 00:50:51 INFO - 'pip_index': False, 00:50:51 INFO - 'sps_profile': False, 00:50:51 INFO - 'sps_profile_interval': 0, 00:50:51 INFO - 'suite': 'dromaeojs', 00:50:51 INFO - 'system_bits': '64', 00:50:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:50:51 INFO - 'title': 'talos-linux64-ix-002', 00:50:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:50:51 INFO - 'use_talos_json': True, 00:50:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:50:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:50:51 INFO - 'work_dir': 'build'} 00:50:51 INFO - ##### 00:50:51 INFO - ##### Running clobber step. 00:50:51 INFO - ##### 00:50:51 INFO - Running pre-action listener: _resource_record_pre_action 00:50:51 INFO - Running main action method: clobber 00:50:51 INFO - rmtree: /builds/slave/test-pgo/build 00:50:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:50:52 INFO - Running post-action listener: _resource_record_post_action 00:50:52 INFO - ##### 00:50:52 INFO - ##### Running read-buildbot-config step. 00:50:52 INFO - ##### 00:50:52 INFO - Running pre-action listener: _resource_record_pre_action 00:50:52 INFO - Running main action method: read_buildbot_config 00:50:52 INFO - Using buildbot properties: 00:50:52 INFO - { 00:50:52 INFO - "properties": { 00:50:52 INFO - "buildnumber": 45, 00:50:52 INFO - "product": "firefox", 00:50:52 INFO - "script_repo_revision": "production", 00:50:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:50:52 INFO - "repository": "", 00:50:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 00:50:52 INFO - "buildid": "20151117233002", 00:50:52 INFO - "slavename": "talos-linux64-ix-002", 00:50:52 INFO - "pgo_build": "True", 00:50:52 INFO - "basedir": "/builds/slave/test-pgo", 00:50:52 INFO - "project": "", 00:50:52 INFO - "platform": "ubuntu64_hw", 00:50:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:50:52 INFO - "slavebuilddir": "test", 00:50:52 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 00:50:52 INFO - "branch": "b2g-inbound", 00:50:52 INFO - "repo_path": "integration/b2g-inbound", 00:50:52 INFO - "stage_platform": "linux64-pgo", 00:50:52 INFO - "builduid": "574433165d95413d9bb27273571b560a", 00:50:52 INFO - "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934" 00:50:52 INFO - }, 00:50:52 INFO - "sourcestamp": { 00:50:52 INFO - "repository": "", 00:50:52 INFO - "hasPatch": false, 00:50:52 INFO - "project": "", 00:50:52 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:50:52 INFO - "changes": [ 00:50:52 INFO - { 00:50:52 INFO - "category": null, 00:50:52 INFO - "files": [ 00:50:52 INFO - { 00:50:52 INFO - "url": null, 00:50:52 INFO - "name": "https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:50:52 INFO - } 00:50:52 INFO - ], 00:50:52 INFO - "repository": "", 00:50:52 INFO - "rev": "7dba29b2ea55f6b26b42046c73b511bb89753934", 00:50:52 INFO - "who": "sendchange", 00:50:52 INFO - "when": 1447836594, 00:50:52 INFO - "number": 6676410, 00:50:52 INFO - "comments": "", 00:50:52 INFO - "project": "", 00:50:52 INFO - "at": "Wed 18 Nov 2015 00:49:54", 00:50:52 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:50:52 INFO - "revlink": "", 00:50:52 INFO - "properties": [ 00:50:52 INFO - [ 00:50:52 INFO - "buildid", 00:50:52 INFO - "20151117233002", 00:50:52 INFO - "Change" 00:50:52 INFO - ], 00:50:52 INFO - [ 00:50:52 INFO - "builduid", 00:50:52 INFO - "574433165d95413d9bb27273571b560a", 00:50:52 INFO - "Change" 00:50:52 INFO - ], 00:50:52 INFO - [ 00:50:52 INFO - "pgo_build", 00:50:52 INFO - "True", 00:50:52 INFO - "Change" 00:50:52 INFO - ] 00:50:52 INFO - ], 00:50:52 INFO - "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934" 00:50:52 INFO - } 00:50:52 INFO - ], 00:50:52 INFO - "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934" 00:50:52 INFO - } 00:50:52 INFO - } 00:50:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:50:52 INFO - Running post-action listener: _resource_record_post_action 00:50:52 INFO - ##### 00:50:52 INFO - ##### Running download-and-extract step. 00:50:52 INFO - ##### 00:50:52 INFO - Running pre-action listener: _resource_record_pre_action 00:50:52 INFO - Running main action method: download_and_extract 00:50:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:50:52 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')]} 00:50:52 INFO - https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/test_packages.json 00:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/test_packages.json 00:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:50:54 INFO - Downloaded 1302 bytes. 00:50:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:50:55 INFO - Using the following test package requirements: 00:50:55 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:55 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:50:55 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'jsshell-linux-x86_64.zip'], 00:50:55 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:50:55 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:55 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:50:55 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:50:55 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:50:55 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:55 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:55 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:50:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:50:55 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')]} 00:50:55 INFO - https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:50:57 INFO - Downloaded 22462620 bytes. 00:50:57 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 00:50:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:57 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 00:50:58 INFO - Return code: 0 00:50:58 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 00:50:58 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')]} 00:50:58 INFO - https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:51:02 INFO - Downloaded 22462620 bytes. 00:51:02 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 00:51:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:02 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 00:51:04 INFO - Return code: 0 00:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:04 INFO - https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:51:05 INFO - Downloaded 11131693 bytes. 00:51:05 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 00:51:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:05 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 00:51:05 INFO - Return code: 0 00:51: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')]} 00:51:05 INFO - https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbsHRxciQ-qhVPcArJArAA/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 00:51:06 INFO - Downloaded 57195394 bytes. 00:51:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:06 INFO - mkdir: /builds/slave/test-pgo/properties 00:51:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:51:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:51:06 INFO - Contents: 00:51:06 INFO - build_url:https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:06 INFO - Running post-action listener: _resource_record_post_action 00:51:06 INFO - Running post-action listener: set_extra_try_arguments 00:51:06 INFO - ##### 00:51:06 INFO - ##### Running populate-webroot step. 00:51:06 INFO - ##### 00:51:06 INFO - Running pre-action listener: _resource_record_pre_action 00:51:06 INFO - Running main action method: populate_webroot 00:51:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:51:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:51:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:51:06 INFO - '../fennec_ids.txt'], 00:51:06 INFO - 'tests': ['tcheck2']}, 00:51:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:51:06 INFO - '--tppagecycles', 00:51:06 INFO - '7'], 00:51:06 INFO - 'tests': ['tsvgm']}}, 00:51:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:51:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:51:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'tests': ['damp', 'tps']}, 00:51:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['damp', 'tps']}, 00:51:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:51:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:51:06 INFO - 'other': {'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'other_l64': {'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'other_nol64': {'tests': ['a11yr', 00:51:06 INFO - 'ts_paint', 00:51:06 INFO - 'tpaint', 00:51:06 INFO - 'sessionrestore', 00:51:06 INFO - 'sessionrestore_no_auto_restore']}, 00:51:06 INFO - 'svgr': {'tests': ['tsvgx', 00:51:06 INFO - 'tsvgr_opacity', 00:51:06 INFO - 'tart', 00:51:06 INFO - 'tscrollx', 00:51:06 INFO - 'cart']}, 00:51:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['tsvgx', 00:51:06 INFO - 'tsvgr_opacity', 00:51:06 INFO - 'tart', 00:51:06 INFO - 'tscrollx', 00:51:06 INFO - 'cart']}, 00:51:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'tests': ['tp5o']}, 00:51:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'talos_options': ['--e10s'], 00:51:06 INFO - 'tests': ['tp5o']}, 00:51:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'talos_options': ['--xperf_path', 00:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:06 INFO - 'tests': ['tp5n']}, 00:51:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:06 INFO - 'talos_options': ['--e10s', 00:51:06 INFO - '--xperf_path', 00:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:06 INFO - 'tests': ['tp5n']}}, 00:51:06 INFO - 'talos.zip': {'path': '', 00:51:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:51:06 INFO - Running post-action listener: _resource_record_post_action 00:51:06 INFO - ##### 00:51:06 INFO - ##### Running create-virtualenv step. 00:51:06 INFO - ##### 00:51:06 INFO - Running pre-action listener: _resource_record_pre_action 00:51:06 INFO - Running main action method: create_virtualenv 00:51:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:51:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:51:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:51:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:51:06 INFO - Using real prefix '/usr' 00:51:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:51:07 INFO - Installing distribute.............................................................................................................................................................................................done. 00:51:09 INFO - Installing pip.................done. 00:51:09 INFO - Return code: 0 00:51:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:51:09 INFO - Using env: {'DISPLAY': ':0', 00:51:09 INFO - 'HOME': '/home/cltbld', 00:51:09 INFO - 'LANG': 'en_US.UTF-8', 00:51:09 INFO - 'LANGUAGE': 'en_US:en', 00:51:09 INFO - 'LOGNAME': 'cltbld', 00:51:09 INFO - 'MAIL': '/var/mail/cltbld', 00:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:09 INFO - 'MOZ_NO_REMOTE': '1', 00:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:09 INFO - 'NO_EM_RESTART': '1', 00:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:09 INFO - 'SHELL': '/bin/bash', 00:51:09 INFO - 'SHLVL': '1', 00:51:09 INFO - 'TERM': 'linux', 00:51:09 INFO - 'TMOUT': '86400', 00:51:09 INFO - 'USER': 'cltbld', 00:51:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:09 INFO - '_': '/tools/buildbot/bin/python'} 00:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:51:09 INFO - Cleaning up... 00:51:09 INFO - Return code: 0 00:51:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:51:09 INFO - Using env: {'DISPLAY': ':0', 00:51:09 INFO - 'HOME': '/home/cltbld', 00:51:09 INFO - 'LANG': 'en_US.UTF-8', 00:51:09 INFO - 'LANGUAGE': 'en_US:en', 00:51:09 INFO - 'LOGNAME': 'cltbld', 00:51:09 INFO - 'MAIL': '/var/mail/cltbld', 00:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:09 INFO - 'MOZ_NO_REMOTE': '1', 00:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:09 INFO - 'NO_EM_RESTART': '1', 00:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:09 INFO - 'SHELL': '/bin/bash', 00:51:09 INFO - 'SHLVL': '1', 00:51:09 INFO - 'TERM': 'linux', 00:51:09 INFO - 'TMOUT': '86400', 00:51:09 INFO - 'USER': 'cltbld', 00:51:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:09 INFO - '_': '/tools/buildbot/bin/python'} 00:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:09 INFO - Downloading/unpacking psutil>=0.7.1 00:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:51:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:11 INFO - Installing collected packages: psutil 00:51:11 INFO - Running setup.py install for psutil 00:51:11 INFO - building 'psutil._psutil_linux' extension 00:51:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:51:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:51:11 INFO - building 'psutil._psutil_posix' extension 00:51:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:51:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:12 INFO - Successfully installed psutil 00:51:12 INFO - Cleaning up... 00:51:12 INFO - Return code: 0 00:51:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:51: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')]} 00:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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', '--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 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:12 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 00:51:12 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 00:51:12 INFO - Using env: {'DISPLAY': ':0', 00:51:12 INFO - 'HOME': '/home/cltbld', 00:51:12 INFO - 'LANG': 'en_US.UTF-8', 00:51:12 INFO - 'LANGUAGE': 'en_US:en', 00:51:12 INFO - 'LOGNAME': 'cltbld', 00:51:12 INFO - 'MAIL': '/var/mail/cltbld', 00:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:12 INFO - 'MOZ_NO_REMOTE': '1', 00:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:12 INFO - 'NO_EM_RESTART': '1', 00:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:12 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:12 INFO - 'SHELL': '/bin/bash', 00:51:12 INFO - 'SHLVL': '1', 00:51:12 INFO - 'TERM': 'linux', 00:51:12 INFO - 'TMOUT': '86400', 00:51:12 INFO - 'USER': 'cltbld', 00:51:12 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:12 INFO - '_': '/tools/buildbot/bin/python'} 00:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:51:13 INFO - Installing collected packages: mozsystemmonitor 00:51:13 INFO - Running setup.py install for mozsystemmonitor 00:51:14 INFO - Successfully installed mozsystemmonitor 00:51:14 INFO - Cleaning up... 00:51:14 INFO - Return code: 0 00:51:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:51:14 INFO - Using env: {'DISPLAY': ':0', 00:51:14 INFO - 'HOME': '/home/cltbld', 00:51:14 INFO - 'LANG': 'en_US.UTF-8', 00:51:14 INFO - 'LANGUAGE': 'en_US:en', 00:51:14 INFO - 'LOGNAME': 'cltbld', 00:51:14 INFO - 'MAIL': '/var/mail/cltbld', 00:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:14 INFO - 'MOZ_NO_REMOTE': '1', 00:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:14 INFO - 'NO_EM_RESTART': '1', 00:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:14 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:14 INFO - 'SHELL': '/bin/bash', 00:51:14 INFO - 'SHLVL': '1', 00:51:14 INFO - 'TERM': 'linux', 00:51:14 INFO - 'TMOUT': '86400', 00:51:14 INFO - 'USER': 'cltbld', 00:51:14 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:14 INFO - '_': '/tools/buildbot/bin/python'} 00:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:14 INFO - Downloading/unpacking blobuploader==1.2.4 00:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:51:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:51:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:16 INFO - Downloading docopt-0.6.1.tar.gz 00:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:51:16 INFO - Installing collected packages: blobuploader, requests, docopt 00:51:16 INFO - Running setup.py install for blobuploader 00:51:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:51:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:51:16 INFO - Running setup.py install for requests 00:51:17 INFO - Running setup.py install for docopt 00:51:17 INFO - Successfully installed blobuploader requests docopt 00:51:17 INFO - Cleaning up... 00:51:17 INFO - Return code: 0 00:51:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:51:17 INFO - Using env: {'DISPLAY': ':0', 00:51:17 INFO - 'HOME': '/home/cltbld', 00:51:17 INFO - 'LANG': 'en_US.UTF-8', 00:51:17 INFO - 'LANGUAGE': 'en_US:en', 00:51:17 INFO - 'LOGNAME': 'cltbld', 00:51:17 INFO - 'MAIL': '/var/mail/cltbld', 00:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:17 INFO - 'MOZ_NO_REMOTE': '1', 00:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:17 INFO - 'NO_EM_RESTART': '1', 00:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:17 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:17 INFO - 'SHELL': '/bin/bash', 00:51:17 INFO - 'SHLVL': '1', 00:51:17 INFO - 'TERM': 'linux', 00:51:17 INFO - 'TMOUT': '86400', 00:51:17 INFO - 'USER': 'cltbld', 00:51:17 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:17 INFO - '_': '/tools/buildbot/bin/python'} 00:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:17 INFO - Running setup.py (path:/tmp/pip-T3Stkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:17 INFO - Running setup.py (path:/tmp/pip-_YW7Fa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:17 INFO - Running setup.py (path:/tmp/pip-lQfDWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:17 INFO - Running setup.py (path:/tmp/pip-gFRVe0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:17 INFO - Running setup.py (path:/tmp/pip-z_TWJv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:17 INFO - Running setup.py (path:/tmp/pip-K0B66N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:17 INFO - Running setup.py (path:/tmp/pip-atEBIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:18 INFO - Running setup.py (path:/tmp/pip-ViYlYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:18 INFO - Running setup.py (path:/tmp/pip-jU0S9N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:18 INFO - Running setup.py (path:/tmp/pip-gOutkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:18 INFO - Running setup.py (path:/tmp/pip-__6z_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:18 INFO - Running setup.py (path:/tmp/pip-zFFHrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:18 INFO - Running setup.py (path:/tmp/pip-lwSoaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:18 INFO - Running setup.py (path:/tmp/pip-myCAro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:18 INFO - Running setup.py (path:/tmp/pip-S_qxl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:18 INFO - Running setup.py (path:/tmp/pip-gwypwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:18 INFO - Running setup.py (path:/tmp/pip-gkRUhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:51:18 INFO - Running setup.py install for manifestparser 00:51:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:51:18 INFO - Running setup.py install for mozcrash 00:51:18 INFO - Running setup.py install for mozdebug 00:51:19 INFO - Running setup.py install for mozdevice 00:51:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for mozfile 00:51:19 INFO - Running setup.py install for mozhttpd 00:51:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for mozinfo 00:51:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for mozInstall 00:51:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for mozleak 00:51:19 INFO - Running setup.py install for mozlog 00:51:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for moznetwork 00:51:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:51:19 INFO - Running setup.py install for mozprocess 00:51:19 INFO - Running setup.py install for mozprofile 00:51:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:51:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:51:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:51:20 INFO - Running setup.py install for mozrunner 00:51:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:51:20 INFO - Running setup.py install for mozscreenshot 00:51:20 INFO - Running setup.py install for moztest 00:51:20 INFO - Running setup.py install for mozversion 00:51:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:51:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:51:20 INFO - Cleaning up... 00:51:20 INFO - Return code: 0 00:51:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:51:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:51:20 INFO - Using env: {'DISPLAY': ':0', 00:51:20 INFO - 'HOME': '/home/cltbld', 00:51:20 INFO - 'LANG': 'en_US.UTF-8', 00:51:20 INFO - 'LANGUAGE': 'en_US:en', 00:51:20 INFO - 'LOGNAME': 'cltbld', 00:51:20 INFO - 'MAIL': '/var/mail/cltbld', 00:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:20 INFO - 'MOZ_NO_REMOTE': '1', 00:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:20 INFO - 'NO_EM_RESTART': '1', 00:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:20 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:20 INFO - 'SHELL': '/bin/bash', 00:51:20 INFO - 'SHLVL': '1', 00:51:20 INFO - 'TERM': 'linux', 00:51:20 INFO - 'TMOUT': '86400', 00:51:20 INFO - 'USER': 'cltbld', 00:51:20 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:20 INFO - '_': '/tools/buildbot/bin/python'} 00:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:20 INFO - Running setup.py (path:/tmp/pip-v8bqq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:20 INFO - Running setup.py (path:/tmp/pip-RTjBjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:20 INFO - Running setup.py (path:/tmp/pip-iTecoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:51:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:20 INFO - Running setup.py (path:/tmp/pip-5udiJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:51:21 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)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:21 INFO - Running setup.py (path:/tmp/pip-_4c_XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:51:21 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)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:21 INFO - Running setup.py (path:/tmp/pip-8d2aX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:21 INFO - Running setup.py (path:/tmp/pip-yYqW98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:21 INFO - Running setup.py (path:/tmp/pip-vkI3pp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:21 INFO - Running setup.py (path:/tmp/pip-yh_a0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:21 INFO - Running setup.py (path:/tmp/pip-HNMYyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:21 INFO - Running setup.py (path:/tmp/pip-l29DTZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:21 INFO - Running setup.py (path:/tmp/pip-bokKTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:21 INFO - Running setup.py (path:/tmp/pip-Hil2xE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:21 INFO - Running setup.py (path:/tmp/pip-2CH2Fp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:21 INFO - Running setup.py (path:/tmp/pip-kHHYo4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:21 INFO - Running setup.py (path:/tmp/pip-VGuE7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:51:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:21 INFO - Running setup.py (path:/tmp/pip-Q5UBrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:23 INFO - Downloading blessings-1.5.1.tar.gz 00:51:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:51:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:51:23 INFO - Installing collected packages: blessings 00:51:23 INFO - Running setup.py install for blessings 00:51:23 INFO - Successfully installed blessings 00:51:23 INFO - Cleaning up... 00:51:23 INFO - Return code: 0 00:51:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:51:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:51:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:51:24 INFO - Reading from file tmpfile_stdout 00:51:24 INFO - Current package versions: 00:51:24 INFO - argparse == 1.2.1 00:51:24 INFO - blessings == 1.5.1 00:51:24 INFO - blobuploader == 1.2.4 00:51:24 INFO - docopt == 0.6.1 00:51:24 INFO - manifestparser == 1.1 00:51:24 INFO - mozInstall == 1.12 00:51:24 INFO - mozcrash == 0.16 00:51:24 INFO - mozdebug == 0.1 00:51:24 INFO - mozdevice == 0.47 00:51:24 INFO - mozfile == 1.2 00:51:24 INFO - mozhttpd == 0.7 00:51:24 INFO - mozinfo == 0.9 00:51:24 INFO - mozleak == 0.1 00:51:24 INFO - mozlog == 3.0 00:51:24 INFO - moznetwork == 0.27 00:51:24 INFO - mozprocess == 0.22 00:51:24 INFO - mozprofile == 0.27 00:51:24 INFO - mozrunner == 6.11 00:51:24 INFO - mozscreenshot == 0.1 00:51:24 INFO - mozsystemmonitor == 0.0 00:51:24 INFO - moztest == 0.7 00:51:24 INFO - mozversion == 1.4 00:51:24 INFO - psutil == 3.1.1 00:51:24 INFO - requests == 1.2.3 00:51:24 INFO - wsgiref == 0.1.2 00:51:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:51:24 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')]} 00:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:24 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')]} 00:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:24 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 0x7ff4f60f3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, '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': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', '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 00:51:24 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 00:51:24 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 00:51:24 INFO - Using env: {'DISPLAY': ':0', 00:51:24 INFO - 'HOME': '/home/cltbld', 00:51:24 INFO - 'LANG': 'en_US.UTF-8', 00:51:24 INFO - 'LANGUAGE': 'en_US:en', 00:51:24 INFO - 'LOGNAME': 'cltbld', 00:51:24 INFO - 'MAIL': '/var/mail/cltbld', 00:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:24 INFO - 'MOZ_NO_REMOTE': '1', 00:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:24 INFO - 'NO_EM_RESTART': '1', 00:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:24 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:24 INFO - 'SHELL': '/bin/bash', 00:51:24 INFO - 'SHLVL': '1', 00:51:24 INFO - 'TERM': 'linux', 00:51:24 INFO - 'TMOUT': '86400', 00:51:24 INFO - 'USER': 'cltbld', 00:51:24 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:24 INFO - '_': '/tools/buildbot/bin/python'} 00:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:51:24 INFO - Cleaning up... 00:51:24 INFO - Return code: 0 00:51:24 INFO - Running post-action listener: _resource_record_post_action 00:51:24 INFO - Running post-action listener: _start_resource_monitoring 00:51:24 INFO - Starting resource monitoring. 00:51:24 INFO - ##### 00:51:24 INFO - ##### Running install step. 00:51:24 INFO - ##### 00:51:24 INFO - Running pre-action listener: _resource_record_pre_action 00:51:24 INFO - Running main action method: install 00:51:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:51:24 INFO - Reading from file tmpfile_stdout 00:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 00:51:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:51:24 INFO - Reading from file tmpfile_stdout 00:51:24 INFO - Output received: 00:51:24 INFO - Usage: mozinstall [options] installer 00:51:24 INFO - Options: 00:51:24 INFO - -h, --help show this help message and exit 00:51:24 INFO - -d DEST, --destination=DEST 00:51:24 INFO - Directory to install application into. [default: 00:51:24 INFO - "/builds/slave/test-pgo"] 00:51:24 INFO - --app=APP Application being installed. [default: firefox] 00:51:24 INFO - mkdir: /builds/slave/test-pgo/build/application 00:51:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:51:38 INFO - Reading from file tmpfile_stdout 00:51:38 INFO - Output received: 00:51:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:51:38 INFO - Running post-action listener: _resource_record_post_action 00:51:38 INFO - ##### 00:51:38 INFO - ##### Running run-tests step. 00:51:38 INFO - ##### 00:51:38 INFO - Running pre-action listener: _resource_record_pre_action 00:51:38 INFO - Running main action method: run_tests 00:51:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:51:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:51:38 INFO - Python 2.7.3 00:51:38 INFO - Return code: 0 00:51:38 INFO - grabbing minidump binary from tooltool 00:51: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')]} 00:51:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb68c0>, '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 0x1f63420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f638b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:51:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 00:51:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:51:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:51:38 INFO - Return code: 0 00:51:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:51:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:51:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:51:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:51:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:51:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:51:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 00:51:38 INFO - Using env: {'DISPLAY': ':0', 00:51:38 INFO - 'HOME': '/home/cltbld', 00:51:38 INFO - 'LANG': 'en_US.UTF-8', 00:51:38 INFO - 'LANGUAGE': 'en_US:en', 00:51:38 INFO - 'LOGNAME': 'cltbld', 00:51:38 INFO - 'MAIL': '/var/mail/cltbld', 00:51:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:51:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:39 INFO - 'MOZ_NO_REMOTE': '1', 00:51:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:39 INFO - 'NO_EM_RESTART': '1', 00:51:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:51:39 INFO - 'PWD': '/builds/slave/test-pgo', 00:51:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:51:39 INFO - 'SHELL': '/bin/bash', 00:51:39 INFO - 'SHLVL': '1', 00:51:39 INFO - 'TERM': 'linux', 00:51:39 INFO - 'TMOUT': '86400', 00:51:39 INFO - 'USER': 'cltbld', 00:51:39 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1447827096.822589-272540105', 00:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:39 INFO - '_': '/tools/buildbot/bin/python'} 00:51:39 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/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 00:51:39 INFO - mozversion INFO | application_buildid: 20151117233002 00:51:39 INFO - mozversion INFO | application_changeset: 7dba29b2ea55f6b26b42046c73b511bb89753934 00:51:39 INFO - mozversion INFO | application_display_name: Nightly 00:51:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:51:39 INFO - mozversion INFO | application_name: Firefox 00:51:39 INFO - mozversion INFO | application_remotingname: firefox 00:51:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:51:39 INFO - mozversion INFO | application_vendor: Mozilla 00:51:39 INFO - mozversion INFO | application_version: 45.0a1 00:51:39 INFO - mozversion INFO | platform_buildid: 20151117233002 00:51:39 INFO - mozversion INFO | platform_changeset: 7dba29b2ea55f6b26b42046c73b511bb89753934 00:51:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:51:39 INFO - mozversion INFO | platform_version: 45.0a1 00:51:39 INFO - 2015-11-18 00:51:39,198 DEBUG : using testdate: 1447836699 00:51:39 INFO - 2015-11-18 00:51:39,198 DEBUG : actual date: 1447836699 00:51:39 INFO - 2015-11-18 00:51:39,206 INFO : starting webserver on 'localhost:39395' 00:51:39 INFO - 2015-11-18 00:51:39,207 INFO : Starting test suite talos-linux64-ix-002 00:51:39 INFO - 2015-11-18 00:51:39,207 INFO : Starting test dromaeo_css 00:51:39 INFO - 2015-11-18 00:51:39,207 DEBUG : operating with platform_type : linux_ 00:51:39 INFO - 2015-11-18 00:51:39,208 INFO : Initialising browser for dromaeo_css test... 00:51:39 INFO - 2015-11-18 00:51:39,222 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZetxZ6/profile http://localhost:39395/getInfo.html 00:51:44 INFO - 2015-11-18 00:51:44,116 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:51:44 INFO - 2015-11-18 00:51:44,116 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:51:44 INFO - 2015-11-18 00:51:44,116 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:51:44 INFO - 2015-11-18 00:51:44,116 DEBUG : BROWSER_OUTPUT: __metrics 00:51:44 INFO - 2015-11-18 00:51:44,273 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:51:45 INFO - 2015-11-18 00:51:45,491 INFO : Browser initialized. 00:51:45 INFO - 2015-11-18 00:51:45,492 INFO : Running cycle 1/1 for dromaeo_css test... 00:51:45 INFO - 2015-11-18 00:51:45,492 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZetxZ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:51:57 INFO - 2015-11-18 00:51:57,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 00:51:57 INFO - 2015-11-18 00:51:57,209 DEBUG : BROWSER_OUTPUT: 00:52:48 INFO - 2015-11-18 00:52:48,674 DEBUG : BROWSER_OUTPUT: 1447836768671 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] 00:54:56 INFO - 2015-11-18 00:54:56,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39395/tests/dromaeo/cssquery-ext.html) 00:54:58 INFO - 2015-11-18 00:54:58,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 294191104 00:54:58 INFO - 2015-11-18 00:54:58,239 DEBUG : BROWSER_OUTPUT: 00:58:00 INFO - 2015-11-18 00:58:00,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-ext.html (next: http://localhost:39395/tests/dromaeo/cssquery-jquery.html) 00:58:01 INFO - 2015-11-18 00:58:01,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 224927744 00:58:01 INFO - 2015-11-18 00:58:01,256 DEBUG : BROWSER_OUTPUT: 01:01:03 INFO - 2015-11-18 01:01:03,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39395/tests/dromaeo/cssquery-mootools.html) 01:01:03 INFO - 2015-11-18 01:01:03,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 216539136 01:01:03 INFO - 2015-11-18 01:01:03,779 DEBUG : BROWSER_OUTPUT: 01:04:05 INFO - 2015-11-18 01:04:05,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39395/tests/dromaeo/cssquery-prototype.html) 01:04:06 INFO - 2015-11-18 01:04:06,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 199499776 01:04:06 INFO - 2015-11-18 01:04:06,230 DEBUG : BROWSER_OUTPUT: 01:07:08 INFO - 2015-11-18 01:07:08,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39395/tests/dromaeo/cssquery-yui.html) 01:07:09 INFO - 2015-11-18 01:07:09,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 205307904 01:07:09 INFO - 2015-11-18 01:07:09,321 DEBUG : BROWSER_OUTPUT: 01:10:11 INFO - 2015-11-18 01:10:11,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/dromaeo/cssquery-yui.html (next: http://localhost:39395/tests/dromaeo/cssquery-dojo.html) 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 274534400 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:10:12 INFO - 2015-11-18 01:10:12,164 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:10:12 INFO - 2015-11-18 01:10:12,167 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3190.154609028608;3211.7591180661457;3277.1151789016967;3290.3912776136417;3300;5102.413222479416;5216.843494695156;5376.64825484737;5394.406615272322;5458.099413596757;5321.467853214676;5337.7598008089635;5403.351597808259;5408.756605952732;5417.45825417458;4847.927281090787;4884.853454396365;4969.105560999019;5062.392512898457;5097.643164978453;4824.493428190042;5036.445990940993;5057.620678449112;5078.59371250301;5101.6683915545555;4908.950910490921;4943.555080042795;5026.8240611578785;5068.138416469209;5084.034033533654;4923.827666031708;4935.851924442272;4967.081089998325;4975;5038.571721403685;4795.520447955211;4896.534829191221;4971.8259860905055;4993.850184494471;5028.34631497903;5059.06407314648;5166.560842328407;5170;5175.715335656538;5199.194124910645;5819.272590926134;5834.737436815311;5835;5857.736401861926;5879.176915231871;5726.055200891848;5786.594938354317;5823.592348535604;5894.675792831393;5905.29136503618;5531.778728850841;5539.806106786243;5542.75057622408;5544.002079625666;5545.61180717354;5985.610935289193;6002.489788368038;6013.278406591237;6016.789412370546;6060.878782424327;5514.420985796433;5617.129344951539;5671.602987790815;5806.738696758656;5808.5062769665055;5776.277965254343;5783;5785.190073389729;5791.913121303184;5794.82615521535;5759.164921086419;5768.423157684282;5771.6537007778825;5775.27809023872;5776.826695199151;5630.5495560355075;5643.40744221859;5712.285964254468;5762.625429347079;5772.826815195467;4486.484054333728;4529.592336689714;4530.207213737583;4530.637548996073;4568.588827005586;3940.408938659167;4030.1939612077704;4033.032072302626;4045.9797701011894;4062.918741625151;5468.644538105011;5472.452754724496;5532.031894418461;5559.749811258423;5582.944170558242;5828.0966450200285;5830.154627578977;5835.649861008353;5835.824925252249;5839.591228613956;5392.91910621341;5517.144842549411;5524.1989911462615;5527.336719593674;5540.445955404508;4901.681390709592;4940.481249468826;5027.3464449621315;5033.295338652519;5073.822416215488;5984.970075149684;5991.101334799728;5993.130996005555;5996.4603185713495;5998.850028749229;5682.403347648437;5814.331351894586;5814.622049566765;5821.417858214145;5835.037218858841;5936.673482958306;6034.275886893601;6034.39656034393;6075.696215189135;6085.391460853879;5773.24947756789;5774.133879918046;5775.451332123442;5776.133579963039;5783.450572195635;5465.945340546544;5580.2466666999435;5847.619904706181;5867.413258674099;5870.17817505541;5566.77732890696;5587.413321601173;5591.329040515164;5591.524720398812;5593.888122237451;5514.751836167462;5547.750351234124;5547.972260138674;5549.084401073939;5559.8888022240135;5497.202905578749;5497.312835895513;5521.337439507285;5621.775128994795;5662.603617746719;5725.456081672234;5779.913301300399;5815.982203114353;5828;5879.265091863517;5680.346760122474;5688.061469857593;5694.373618901835;5698.715064246854;5703.486686198262 01:10:12 INFO - 2015-11-18 01:10:12,168 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.9048674112;588.6821116597038;600.5345856960855;606.4329851588767;623.1742940603701;31673.68326316736;32641;40118.598814011886;40436;40589;43970.34044489335;44257.33613995793;44353.77823110888;44371.33442998349;44469.77765111178;8720.345974051956;8888.555572221396;8902.332325075646;8903.732888013337;8906.821863562725;7635.312821846032;7890.132085470594;10490.842637360445;10753.56985720574;10758.78482430351;10472.528736206888;10511.84232236517;10569.788604227911;10582.894171058268;10591.523381447852;7746;10446.164306855471;10508.579656813794;10526.526306316235;10551.155907527418;7621.085469743666;10549;10747.892521074768;10819.78360432787;10829.729256768565;40245;40667.389989150186;40676.59323406758;40706.796466017775;40802.38796418056;3344.6488118747425;3408.1820363112674;3735.2716220337047;3949.7037722170667;4065.3292206785845;30245.697543024507;30462.086137415914;30472.8476357619;30809.537856932166;31649.683503164903;3535.744810592254;3568.982155089234;3589.10272431892;3598.478220658016;3718.3864662330684;285144;285587;285701;285881;286084;53188.99999999923;54065;60223.69888150531;60558.39441605616;60637.69681151566;68607;69741;70162.64918675374;70248;70294;14587.05184163026;14817.70364592702;14860.405583776745;14908.925455372872;14921.776173357408;11758.235714678689;11847.76304473923;11853.940730296294;11889.643310700692;11891.227070240408;19509.8049019508;19573.51066223356;19608.313709020116;19638;19992.800071999383;7818.843623127505;8020.19798020205;8158.510489370657;8262.876056859152;8276.172382761795;860.8149247911729;925.287528602972;937.5968333616474;993.7813680990171;1065.79217052674;26024.86987565088;26397.47205055888;26454.33864153373;28851.42297154045;29863.701362986092;992.6523771281013;1025.7692019295748;1084.5173897615643;1153.9711507212219;1155.5320095361392;13585.864141358657;13633.590992270249;13699.109557878706;13765.38055787492;13810.240436776074;341254;346660;346660;346664;348024;51869.7406512965;51879.48120518746;52176.739116304176;52435.47564524306;52513.2123018155;1285.5629086110766;1354.2416246901766;1361.4077876123918;1366.631009627395;1378.9034767566375;27265.31836704098;28273.717262827107;28322;28558.286042849097;29582.260443489085;48326.51673483361;49252.507474924794;55206.44793552174;56372.43627563672;56408.15387769269;282820;283714;284462;284929;286300;27740;28156.85921570461;31330.843345783127;31709.20726981844;31758.206044849063;44131.338029928935;44229.115417690824;44296.77851610721;44446.55553444424;44683.329750053126;36027.63972360243;36593.45109823408;36620;36818.263634726616;37083;35038;36553.63446365609;36600.81699591485;37583.43624845684;38703.61296387;35381.1154721134;36628;36748.44877326896;36813.26373472569;36879.07802304964;29769.404611908074;32985.897608942425;33646;33657.663423365455;33663.3267334647;23843.284701458982;24281.150159744324;24412;24704.505909881344;24916.626250605892 01:10:12 INFO - 2015-11-18 01:10:12,171 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.07778243262135;363.24807648168303;363.73447383410104;366.6168853548042;368.7179307829511;14379.784303235434;15049;16730.498085057454;17600.38398656047;18319;16627.66744665106;16692.499225023268;16799.496015119534;16889.23998420071;17029.318827246927;5134.845954621367;5237.10969135246;5268.578513718893;5269;5270.631055826094;3838.0788610733503;3950.881473555798;5307.150855863063;5866.178734977086;6040.426159514839;5946.613470124428;5951;5969.343372229051;5975.701214939258;5982.43166899146;5735.942640573603;5901.822945311647;5903.085021821625;5910.202122713443;5913.645181289094;5211.530962213419;5215;5217.217417387422;5221.921671174935;5222.138347172712;13249;13359.398827052708;13448.1258718183;13577.321133943264;13589.116707413987;1812.2932056497975;1967.498287936567;2037.4397040813894;2098.6432306507777;2125.0649714125734;9975.800483990351;10112.63758017262;10224.079832815083;10245.538950747234;10347.844782328271;1623.1721821870813;1691.798822835788;1713.20336043739;1713.6658351621438;1736.9565760855953;57476.42523574753;58780.41219587835;58908.11637825436;59576.70211648957;59980.100298495556;7058.082449281561;7119.4660400470175;7147.785566433015;7151.89272160918;7182.8204294892;8515.27620152294;8519.148085191431;8523.531205783618;8554.957225213833;8576.914230857736;5786.450287222707;5826.41735826414;5836.620619659709;5860.794872179454;5871.588988770745;6146.078088286703;6152.323244443108;6158.445739883432;6190.380961903774;6202.844928876724;3344.414727422691;3349.9330013399594;3376.594808622981;3388.8136152511847;3404.38721030212;1061.7186445591924;1128.5147386623667;1172.3786393211612;1175.400545721688;1217.3000524698334;415.8045718512294;423.74151767421847;426.3115069163279;499.61030396290954;503.25769490001954;10535.894641053492;10827.891721082846;10983.176261780398;11029;11075.833862492069;448.92143874822426;449.0816280705964;449.1062785057712;464.0162854747956;464.52154281089855;5845.473907348359;5899.852503687356;5919.763209471659;6047.304559975659;6054.061620448838;560065;560357;563004;570842;574017;71127.64436177786;71532.64233678798;72299;73673.63163184257;73987;504.25873965270995;512.2086376548242;513.194284972597;513.5301199402505;514.3236643813299;9862.901370986197;9965.750856228653;10108.292419530562;10164.288499804943;10239.897601023895;33609.15977100494;33688;34109.65890341065;34654.306913862085;34730.479042814884;46246.768766155954;46840.297395539776;47034.764826177015;47373.7631311855;48070.75964620154;6794.966025169842;6836.692348844214;6852.45180385558;6895.069165662772;6895.172579290517;12266.938665306616;12520.123591348518;12844.743105138032;12853.293068881301;12872.806907896576;8976.685815996409;9235.630574776933;9385.202257808163;11204.83192752093;11244.325340479598;9881.357711748713;10235.334703244265;10426.27016108865;10466.63366782159;10613.628523001658;9059.728208153765;9274.489903055397;10481.161507079567;10556.84164737545;10784.838227426439;14635.85364146345;14822.184779836782;14915.179665118523;15079.24603769829;15211.923940380228;14791.334389952694;15768.053916765031;15817.525474235792;16118.919405403367;16644 01:10:12 INFO - 2015-11-18 01:10:12,172 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.629390064683;1718.3212631010751;1769.27459741506;1791.1581556668361;1804.260253296149;6678.465722742181;7367.5211111277795;7535.397168226543;7548.282913123258;7549.50928189668;7703.807404814883;7822.335101516378;7825.452218344718;7825.804354891131;7864.056313242405;2038.8368930485526;2092.06902928197;2272.9659055114143;2280.726312842453;2285.325828880476;2336.3925379401394;2340.8595484271;2341.3444235614056;2341.4146463384154;2343.425860664131;2258.0741895822716;2346.378209774411;2348.7886090251873;2350.2831636350907;2352.3531028967;2036.6028624418245;2086.019570801721;2283.748787633359;2323.256557901472;2324.23300310897;2318.2465698648007;2325.476767727265;2351.4356554426813;2352.3413444235644;2371.5968285391523;7812.765617031499;7816.921830781676;7866.960665196694;7878.1727918568295;7879.684812607489;4797.640176986705;4883.072216278895;4906.386701662293;4906.632002599819;4911.238757992517;3145.3866496033284;3149.889753858627;3188.3304506053755;3254.8535315910603;3276.9836150819333;1030.6135199300263;1047.036805988771;1053.973650658732;1083.409541799721;1091.0671375973586;10788.406637634927;10811.459427028696;10817.080548153417;10817.621383251548;10861.782764344747;4347.282698354736;4391.802368893344;4492.640588752892;4499.392582001388;4503.054358584734;9193;9209.35534512591;9212.447253164832;9217.95391023054;9223.077692230723;4883.340748998839;4916.852494425101;4948.1835497142565;4948.851534453972;4953.925691114636;4429.335599660077;4476.239039363316;4513.526079761644;4519.570640789119;4520.208963431386;3714.7399682022;3718.572364178154;3731.552213734369;3741.6819570336825;3760.247950409874;1241.4847838147068;1254.736505333872;1256.8303279057393;1258.314218750783;1263.5577547858177;1008.1682611845257;1039.1998161415668;1285.3380509037852;1313.382710126239;1325.185011218094;7371.741989030358;7565.773026809205;7596.430267729832;7634.770956871303;7653.425993050543;703.409136325489;704.9118860142482;710.5381502023725;721.7401735375261;730.0545793197822;5866.67733274674;5913.172155898178;5915.704214789243;5916.26046744157;5927.288725352985;9183.77040573991;9320.254379649612;9448.385854919547;9488.098630630078;9643.662471813454;9453.71638850822;9503.524823758922;9503.57233924475;9504.42973421597;9511.381760185566;6930.514863959575;7071.080759501335;7135.78592642232;7363.079615048119;7407.111146662435;7368.078990126234;7402.555846649218;7409.296116868889;7424.740134095281;7434.7769566913075;8235.876461853197;8375.539345336065;8475.915240847758;8511.021232558087;8601.569921504026;8678.956605216934;8783.385163038525;8798.516081615573;8812.030676625438;8826.470411775057;6876.553024053421;7128.394086502705;7156.463265255231;7161.677724502514;7169.856602867809;7648.08223013242;7649.235076492307;7658.617069146632;7666.4633475656165;7666.655000525101;6931.133608298963;6980.127484064492;7149.356557909605;7238.457115716237;7283.8543229136185;6954.3393377629045;7032.296770322927;7048.577085374894;7069.82325441868;7076.150861896605;7178.4257259420165;7205.927940720735;7211.71153153868;7244.4566657499845;7256.96371518139;6362.395572420613;6430.807075787734;6478.935210647834;6494.383033611799;6504.317046710027;6452.870942581216;6484.416402523795;6731.966340168267;6732.124823772878;6744.494162937897 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: |4;prototype.html;339.11998364244783;345.832271348396;347.4440894568689;349.3885700024956;356.937535931212;5968.9701551492235;6012.909806352908;6044.939550604498;6065.545084118698;6093.4211249931295;5767.336756273019;5788.82633520995;5893.469587737103;5975.760969561224;5991.670458124812;4628.768561571925;4649.744264065492;4651;4661.347411362412;4663.60359369454;4401.207782599131;4665.556772106662;4673.556012178855;4673.672842900998;4680.719156850583;4434.844780432685;4507;4605.171069207541;4608.654350923694;4640.60554852838;4596;4599.310103484488;4606.654500912411;4615.261558150713;4620.607248383892;4068.6541643960004;4077.347624380085;4081.6326530612387;4090.6931980101613;4093.2836753568304;5560.2493663355335;5682.431756824326;5682.488576028136;5685.204071430003;5691.459311365414;5285.973570132125;5298.470152984709;5313.442088580682;5320;5333.413324534337;6369.108324834527;6369.681515924185;6372.553921225516;6374.808755737289;6385.393387628168;4248.745075295492;4351.129774045204;4360.258756011485;4431.867043988654;4458.063806600618;6530.6734663267125;6570.770023049218;6584.078229047937;6595.835104122388;6613.173353330833;4539.75031373271;4540.750258735801;4542.295944128666;4547.704399214041;4550.408446901948;4507.729536227836;4592.425946756655;4593.150267200579;4594.081183763261;4595.4025976622825;5299.549538289211;5311.415744268127;5324.946750532523;5325.813596524103;5327.121025030904;6429.6463694496315;6429.742810287629;6436.581622194542;6438.903416448757;6440.806775796734;1602.6954878573033;1603.4067395063669;1603.871690264776;1604.1498006056809;1605.8715302775984;1033.421284080902;1068.9679309620724;1077.472038701031;1089.629525961161;1120.047959234644;6208.844778880474;6233.501319894398;6235;6238.970569856014;6252.718627661675;6540.2805691373915;6589.670516474157;6590.044443555657;6594.8351291218105;6600.339966003457;6087.981931924908;6190.659513726789;6236.501079913596;6246.531510136758;6251.28110267316;3548.2193917338145;3576.5886923004186;3579.1410061585034;3580.588232353313;3583.605803361628;6812.4550035997;6813.807583672838;6826.795196144024;6830.282820303796;6837.179538455417;6641.970494573349;6768.661566921634;6768.763093291711;6779.966100169468;6784.626845523544;6780.7287708492095;6811.863762724817;6817.829554261183;6820.249772525019;6824.556403833834;6574.112494813139;6577.046328282468;6580.7038683260325;6583.835404114935;6603.240627327918;6353.523485738496;6354.1104245406605;6496.7726129585235;6578.5395022347975;6580.967095164685;6835.316468353324;6864.313568643096;6876.5186436950935;6887.414569761627;6894.724211031503;4543.45478542577;4566.725996440225;4568.680192386501;4578.702384345007;4582.656300777388;6461.935380646133;6495.285518593046;6629.535932484872;6653.434458071119;6701.765438209639;6506.121673574007;6509.804705858832;6512.73949042033;6513.706883190173;6518.641474718936;6487.805365839033;6499.707513161825;6505.837354066186;6508.186476690414;6510.967445162744;6202.596831205957;6353.841153971188;6358.205224346957;6368.77709280173;6372.107904893226;6443.226812782309;6492.415682588589;6500.382463665944;6502.967485162544;6513.706883190173;6171.938280617136;6341.048842673451;6341.90487142684;6352.110704501466;6358.427741503102 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: |5;yui.html;844.1642773654081;846.7036537211976;857.4855086947828;858.7380848841101;886.1537231943495;13251.536196233134;13483.056186066968;13487.730245395087;13502.189868607891;13508.121972071809;13298.800517992238;13378.531751388704;13385.66535836602;13388.799168012487;13406.061575689706;684.907537482441;692.9826754331157;818.3698552114882;833.1834801894117;833.6665333866472;828.888100106487;829.9585020748939;830.4353039932844;832.5545832979358;838.4717627894418;870.9259712924409;888.3381880499005;888.995555022224;889.0798024045115;889.1375365895071;720.8846584546474;726.3172617739308;867.2974890338783;876.2814492116468;878.1043335797483;644.0789670770796;647.5920170292733;648.044134901022;648.4293821437152;649.2436311696868;13636.93181534086;13754.105983111165;13763.793543096861;13790.931045344809;13795.379207935666;11931.164818462712;12484.50061997519;12501.187422817487;12632.873671263262;13234.801477977839;10326.173906087495;10383.740406489898;10450.843237351446;10461.843072353844;10627.84058239127;3314.6188188358165;3341.081202669261;3373.3590617782543;3429.2798512312443;3429.4684323929832;44005.77997110026;45907.311390329174;46134;46143;46145.53854461479;7479.8504029919095;7644.788412947823;7754.340881025063;7888.290053895177;7894.486858354188;11750.882491174978;11752.764944701059;11775.764484710258;11785.941070294593;11797.823032654516;6712.42944349726;6788.422984046312;6821.113255276881;6978.162620485574;7088.0785497884945;4292.7424354538825;4300.741955482681;4343.326784348431;4379.3649920761945;4401.735895846259;2847.373577812878;2864.627598412193;2864.9856750716112;2873.6264285642733;2881.423715256957;474.71517089745873;476.1358134984991;479.1136397664363;487.3177551428029;488.4334172360045;642.4924309795302;674.2280089297825;693.9861202775916;696.9303069692991;708.4343600642637;8863.468191908507;9059.184673379428;9238.307126965505;9744.561494732754;9810.117089461983;594.6224147666263;643.9420452159328;705.2982282628817;707.738136889344;745.3776096958992;4051.5948405159247;4343.9348409773875;4509.098180363875;4531.365608814768;4587.1513769952;52184.47815521872;52797;53034.46965530295;53269;53399.733001335524;46697.766511167225;47068.05863882703;47411.5258847414;47522.28716569254;47961.760191198824;45035;46474.302885456746;46752;47652.99999999931;48002.759986199846;8904.154105359981;9015.639374424949;9145.817083658423;9281.535923203948;9432.481213533321;32918.506222406206;34919.82540087283;35199.82400087983;36090;36513.63486365102;44055.779721101186;44703.32945005762;44931.32603010892;45085.32372014488;45263.09473810571;8223.794405139919;8312.25189732927;8460.450070745383;8493.87259191125;8541.701040463802;12058.819117713418;12082;12118;12295.938520307342;12495.625131246077;11115.88884111181;11340.432978351215;11385.03227225662;11734;11740.354280514654;11478.770424591294;11684.649460516199;12000.939995299968;12216.755664886474;12254.20347677398;11166.44167791591;11378.146639001943;11469.992221214792;11544.076473882238;11745.17783755129;9985.850212246967;10155.695329140137;10159.542820572944;10234.948825255826;10272.537735802056;9302.720918372459;9589.184919281939;9725.693204807661;9739.513024348613;9744.561494732612 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1193 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837812163__endTimestamp 01:10:12 INFO - 2015-11-18 01:10:12,174 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,175 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:10:12 INFO - 2015-11-18 01:10:12,175 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:10:12 INFO - 2015-11-18 01:10:12,175 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,175 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5396.62 Median:5559.75 stddev:590.81 (10.6%) stddev-sans-first:566.70 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: Values: 3190.2 3211.8 3277.1 3290.4 3300.0 5102.4 5216.8 5376.6 5394.4 5458.1 5321.5 5337.8 5403.4 5408.8 5417.5 4847.9 4884.9 4969.1 5062.4 5097.6 4824.5 5036.4 5057.6 5078.6 5101.7 4909.0 4943.6 5026.8 5068.1 5084.0 4923.8 4935.9 4967.1 4975.0 5038.6 4795.5 4896.5 4971.8 4993.9 5028.3 5059.1 5166.6 5170.0 5175.7 5199.2 5819.3 5834.7 5835.0 5857.7 5879.2 5726.1 5786.6 5823.6 5894.7 5905.3 5531.8 5539.8 5542.8 5544.0 5545.6 5985.6 6002.5 6013.3 6016.8 6060.9 5514.4 5617.1 5671.6 5806.7 5808.5 5776.3 5783.0 5785.2 5791.9 5794.8 5759.2 5768.4 5771.7 5775.3 5776.8 5630.5 5643.4 5712.3 5762.6 5772.8 4486.5 4529.6 4530.2 4530.6 4568.6 3940.4 4030.2 4033.0 4046.0 4062.9 5468.6 5472.5 5532.0 5559.7 5582.9 5828.1 5830.2 5835.6 5835.8 5839.6 5392.9 5517.1 5524.2 5527.3 5540.4 4901.7 4940.5 5027.3 5033.3 5073.8 5985.0 5991.1 5993.1 5996.5 5998.9 5682.4 5814.3 5814.6 5821.4 5835.0 5936.7 6034.3 6034.4 6075.7 6085.4 5773.2 5774.1 5775.5 5776.1 5783.5 5465.9 5580.2 5847.6 5867.4 5870.2 5566.8 5587.4 5591.3 5591.5 5593.9 5514.8 5547.8 5548.0 5549.1 5559.9 5497.2 5497.3 5521.3 5621.8 5662.6 5725.5 5779.9 5816.0 5828.0 5879.3 5680.3 5688.1 5694.4 5698.7 5703.5 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47987.46 Median:343957.00 stddev:80264.18 (23.3%) stddev-sans-first:80410.33 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: Values: 555.9 588.7 600.5 606.4 623.2 31673.7 32641.0 40118.6 40436.0 40589.0 43970.3 44257.3 44353.8 44371.3 44469.8 8720.3 8888.6 8902.3 8903.7 8906.8 7635.3 7890.1 10490.8 10753.6 10758.8 10472.5 10511.8 10569.8 10582.9 10591.5 7746.0 10446.2 10508.6 10526.5 10551.2 7621.1 10549.0 10747.9 10819.8 10829.7 40245.0 40667.4 40676.6 40706.8 40802.4 3344.6 3408.2 3735.3 3949.7 4065.3 30245.7 30462.1 30472.8 30809.5 31649.7 3535.7 3569.0 3589.1 3598.5 3718.4 285144.0 285587.0 285701.0 285881.0 286084.0 53189.0 54065.0 60223.7 60558.4 60637.7 68607.0 69741.0 70162.6 70248.0 70294.0 14587.1 14817.7 14860.4 14908.9 14921.8 11758.2 11847.8 11853.9 11889.6 11891.2 19509.8 19573.5 19608.3 19638.0 19992.8 7818.8 8020.2 8158.5 8262.9 8276.2 860.8 925.3 937.6 993.8 1065.8 26024.9 26397.5 26454.3 28851.4 29863.7 992.7 1025.8 1084.5 1154.0 1155.5 13585.9 13633.6 13699.1 13765.4 13810.2 341254.0 346660.0 346660.0 346664.0 348024.0 51869.7 51879.5 52176.7 52435.5 52513.2 1285.6 1354.2 1361.4 1366.6 1378.9 27265.3 28273.7 28322.0 28558.3 29582.3 48326.5 49252.5 55206.4 56372.4 56408.2 282820.0 283714.0 284462.0 284929.0 286300.0 27740.0 28156.9 31330.8 31709.2 31758.2 44131.3 44229.1 44296.8 44446.6 44683.3 36027.6 36593.5 36620.0 36818.3 37083.0 35038.0 36553.6 36600.8 37583.4 38703.6 35381.1 36628.0 36748.4 36813.3 36879.1 29769.4 32985.9 33646.0 33657.7 33663.3 23843.3 24281.2 24412.0 24704.5 24916.6 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27994.23 Median:464.27 stddev:92507.43 (19925.4%) stddev-sans-first:92743.66 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: Values: 363.1 363.2 363.7 366.6 368.7 14379.8 15049.0 16730.5 17600.4 18319.0 16627.7 16692.5 16799.5 16889.2 17029.3 5134.8 5237.1 5268.6 5269.0 5270.6 3838.1 3950.9 5307.2 5866.2 6040.4 5946.6 5951.0 5969.3 5975.7 5982.4 5735.9 5901.8 5903.1 5910.2 5913.6 5211.5 5215.0 5217.2 5221.9 5222.1 13249.0 13359.4 13448.1 13577.3 13589.1 1812.3 1967.5 2037.4 2098.6 2125.1 9975.8 10112.6 10224.1 10245.5 10347.8 1623.2 1691.8 1713.2 1713.7 1737.0 57476.4 58780.4 58908.1 59576.7 59980.1 7058.1 7119.5 7147.8 7151.9 7182.8 8515.3 8519.1 8523.5 8555.0 8576.9 5786.5 5826.4 5836.6 5860.8 5871.6 6146.1 6152.3 6158.4 6190.4 6202.8 3344.4 3349.9 3376.6 3388.8 3404.4 1061.7 1128.5 1172.4 1175.4 1217.3 415.8 423.7 426.3 499.6 503.3 10535.9 10827.9 10983.2 11029.0 11075.8 448.9 449.1 449.1 464.0 464.5 5845.5 5899.9 5919.8 6047.3 6054.1 560065.0 560357.0 563004.0 570842.0 574017.0 71127.6 71532.6 72299.0 73673.6 73987.0 504.3 512.2 513.2 513.5 514.3 9862.9 9965.8 10108.3 10164.3 10239.9 33609.2 33688.0 34109.7 34654.3 34730.5 46246.8 46840.3 47034.8 47373.8 48070.8 6795.0 6836.7 6852.5 6895.1 6895.2 12266.9 12520.1 12844.7 12853.3 12872.8 8976.7 9235.6 9385.2 11204.8 11244.3 9881.4 10235.3 10426.3 10466.6 10613.6 9059.7 9274.5 10481.2 10556.8 10784.8 14635.9 14822.2 14915.2 15079.2 15211.9 14791.3 15768.1 15817.5 16118.9 16644.0 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,177 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5540.38 Median:6499.35 stddev:2856.65 (44.0%) stddev-sans-first:2847.48 01:10:12 INFO - 2015-11-18 01:10:12,178 DEBUG : BROWSER_OUTPUT: Values: 1372.6 1718.3 1769.3 1791.2 1804.3 6678.5 7367.5 7535.4 7548.3 7549.5 7703.8 7822.3 7825.5 7825.8 7864.1 2038.8 2092.1 2273.0 2280.7 2285.3 2336.4 2340.9 2341.3 2341.4 2343.4 2258.1 2346.4 2348.8 2350.3 2352.4 2036.6 2086.0 2283.7 2323.3 2324.2 2318.2 2325.5 2351.4 2352.3 2371.6 7812.8 7816.9 7867.0 7878.2 7879.7 4797.6 4883.1 4906.4 4906.6 4911.2 3145.4 3149.9 3188.3 3254.9 3277.0 1030.6 1047.0 1054.0 1083.4 1091.1 10788.4 10811.5 10817.1 10817.6 10861.8 4347.3 4391.8 4492.6 4499.4 4503.1 9193.0 9209.4 9212.4 9218.0 9223.1 4883.3 4916.9 4948.2 4948.9 4953.9 4429.3 4476.2 4513.5 4519.6 4520.2 3714.7 3718.6 3731.6 3741.7 3760.2 1241.5 1254.7 1256.8 1258.3 1263.6 1008.2 1039.2 1285.3 1313.4 1325.2 7371.7 7565.8 7596.4 7634.8 7653.4 703.4 704.9 710.5 721.7 730.1 5866.7 5913.2 5915.7 5916.3 5927.3 9183.8 9320.3 9448.4 9488.1 9643.7 9453.7 9503.5 9503.6 9504.4 9511.4 6930.5 7071.1 7135.8 7363.1 7407.1 7368.1 7402.6 7409.3 7424.7 7434.8 8235.9 8375.5 8475.9 8511.0 8601.6 8679.0 8783.4 8798.5 8812.0 8826.5 6876.6 7128.4 7156.5 7161.7 7169.9 7648.1 7649.2 7658.6 7666.5 7666.7 6931.1 6980.1 7149.4 7238.5 7283.9 6954.3 7032.3 7048.6 7069.8 7076.2 7178.4 7205.9 7211.7 7244.5 7257.0 6362.4 6430.8 6478.9 6494.4 6504.3 6452.9 6484.4 6732.0 6732.1 6744.5 01:10:12 INFO - 2015-11-18 01:10:12,178 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5356.88 Median:6132.68 stddev:1616.52 (26.4%) stddev-sans-first:1576.57 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: Values: 339.1 345.8 347.4 349.4 356.9 5969.0 6012.9 6044.9 6065.5 6093.4 5767.3 5788.8 5893.5 5975.8 5991.7 4628.8 4649.7 4651.0 4661.3 4663.6 4401.2 4665.6 4673.6 4673.7 4680.7 4434.8 4507.0 4605.2 4608.7 4640.6 4596.0 4599.3 4606.7 4615.3 4620.6 4068.7 4077.3 4081.6 4090.7 4093.3 5560.2 5682.4 5682.5 5685.2 5691.5 5286.0 5298.5 5313.4 5320.0 5333.4 6369.1 6369.7 6372.6 6374.8 6385.4 4248.7 4351.1 4360.3 4431.9 4458.1 6530.7 6570.8 6584.1 6595.8 6613.2 4539.8 4540.8 4542.3 4547.7 4550.4 4507.7 4592.4 4593.2 4594.1 4595.4 5299.5 5311.4 5324.9 5325.8 5327.1 6429.6 6429.7 6436.6 6438.9 6440.8 1602.7 1603.4 1603.9 1604.1 1605.9 1033.4 1069.0 1077.5 1089.6 1120.0 6208.8 6233.5 6235.0 6239.0 6252.7 6540.3 6589.7 6590.0 6594.8 6600.3 6088.0 6190.7 6236.5 6246.5 6251.3 3548.2 3576.6 3579.1 3580.6 3583.6 6812.5 6813.8 6826.8 6830.3 6837.2 6642.0 6768.7 6768.8 6780.0 6784.6 6780.7 6811.9 6817.8 6820.2 6824.6 6574.1 6577.0 6580.7 6583.8 6603.2 6353.5 6354.1 6496.8 6578.5 6581.0 6835.3 6864.3 6876.5 6887.4 6894.7 4543.5 4566.7 4568.7 4578.7 4582.7 6461.9 6495.3 6629.5 6653.4 6701.8 6506.1 6509.8 6512.7 6513.7 6518.6 6487.8 6499.7 6505.8 6508.2 6511.0 6202.6 6353.8 6358.2 6368.8 6372.1 6443.2 6492.4 6500.4 6503.0 6513.7 6171.9 6341.0 6341.9 6352.1 6358.4 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13277.95 Median:46586.03 stddev:15255.80 (32.7%) stddev-sans-first:15270.02 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: Values: 844.2 846.7 857.5 858.7 886.2 13251.5 13483.1 13487.7 13502.2 13508.1 13298.8 13378.5 13385.7 13388.8 13406.1 684.9 693.0 818.4 833.2 833.7 828.9 830.0 830.4 832.6 838.5 870.9 888.3 889.0 889.1 889.1 720.9 726.3 867.3 876.3 878.1 644.1 647.6 648.0 648.4 649.2 13636.9 13754.1 13763.8 13790.9 13795.4 11931.2 12484.5 12501.2 12632.9 13234.8 10326.2 10383.7 10450.8 10461.8 10627.8 3314.6 3341.1 3373.4 3429.3 3429.5 44005.8 45907.3 46134.0 46143.0 46145.5 7479.9 7644.8 7754.3 7888.3 7894.5 11750.9 11752.8 11775.8 11785.9 11797.8 6712.4 6788.4 6821.1 6978.2 7088.1 4292.7 4300.7 4343.3 4379.4 4401.7 2847.4 2864.6 2865.0 2873.6 2881.4 474.7 476.1 479.1 487.3 488.4 642.5 674.2 694.0 696.9 708.4 8863.5 9059.2 9238.3 9744.6 9810.1 594.6 643.9 705.3 707.7 745.4 4051.6 4343.9 4509.1 4531.4 4587.2 52184.5 52797.0 53034.5 53269.0 53399.7 46697.8 47068.1 47411.5 47522.3 47961.8 45035.0 46474.3 46752.0 47653.0 48002.8 8904.2 9015.6 9145.8 9281.5 9432.5 32918.5 34919.8 35199.8 36090.0 36513.6 44055.8 44703.3 44931.3 45085.3 45263.1 8223.8 8312.3 8460.5 8493.9 8541.7 12058.8 12082.0 12118.0 12295.9 12495.6 11115.9 11340.4 11385.0 11734.0 11740.4 11478.8 11684.6 12000.9 12216.8 12254.2 11166.4 11378.1 11470.0 11544.1 11745.2 9985.9 10155.7 10159.5 10234.9 10272.5 9302.7 9589.2 9725.7 9739.5 9744.6 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:10:12 INFO - 2015-11-18 01:10:12,179 DEBUG : BROWSER_OUTPUT: 01:10:12 INFO - 2015-11-18 01:10:12,913 INFO : Browser exited with error code: 0 01:10:12 INFO - 2015-11-18 01:10:12,934 INFO : Completed test dromaeo_css (00:18:33) 01:10:12 INFO - 2015-11-18 01:10:12,934 INFO : Starting test kraken 01:10:12 INFO - 2015-11-18 01:10:12,934 DEBUG : operating with platform_type : linux_ 01:10:12 INFO - 2015-11-18 01:10:12,934 INFO : Initialising browser for kraken test... 01:10:12 INFO - 2015-11-18 01:10:12,940 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp413uTG/profile http://localhost:39395/getInfo.html 01:10:16 INFO - 2015-11-18 01:10:16,748 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:10:16 INFO - 2015-11-18 01:10:16,749 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:10:16 INFO - 2015-11-18 01:10:16,749 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:10:16 INFO - 2015-11-18 01:10:16,749 DEBUG : BROWSER_OUTPUT: __metrics 01:10:16 INFO - 2015-11-18 01:10:16,886 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:10:18 INFO - 2015-11-18 01:10:18,159 INFO : Browser initialized. 01:10:18 INFO - 2015-11-18 01:10:18,159 INFO : Running cycle 1/1 for kraken test... 01:10:18 INFO - 2015-11-18 01:10:18,160 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp413uTG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:10:29 INFO - 2015-11-18 01:10:29,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 141570048 01:10:29 INFO - 2015-11-18 01:10:29,946 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39395/tests/kraken/driver.html?testName=audio-beat-detection) 01:10:33 INFO - 2015-11-18 01:10:33,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 180027392 01:10:33 INFO - 2015-11-18 01:10:33,002 DEBUG : BROWSER_OUTPUT: 01:10:35 INFO - 2015-11-18 01:10:35,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39395/tests/kraken/driver.html?testName=audio-dft) 01:10:36 INFO - 2015-11-18 01:10:36,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 170233856 01:10:36 INFO - 2015-11-18 01:10:36,177 DEBUG : BROWSER_OUTPUT: 01:10:39 INFO - 2015-11-18 01:10:39,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39395/tests/kraken/driver.html?testName=audio-fft) 01:10:39 INFO - 2015-11-18 01:10:39,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 152096768 01:10:39 INFO - 2015-11-18 01:10:39,668 DEBUG : BROWSER_OUTPUT: 01:10:41 INFO - 2015-11-18 01:10:41,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39395/tests/kraken/driver.html?testName=audio-oscillator) 01:10:42 INFO - 2015-11-18 01:10:42,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 154525696 01:10:42 INFO - 2015-11-18 01:10:42,222 DEBUG : BROWSER_OUTPUT: 01:10:44 INFO - 2015-11-18 01:10:44,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:10:44 INFO - 2015-11-18 01:10:44,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 156270592 01:10:44 INFO - 2015-11-18 01:10:44,930 DEBUG : BROWSER_OUTPUT: 01:10:47 INFO - 2015-11-18 01:10:47,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39395/tests/kraken/driver.html?testName=imaging-darkroom) 01:10:48 INFO - 2015-11-18 01:10:48,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 156688384 01:10:48 INFO - 2015-11-18 01:10:48,435 DEBUG : BROWSER_OUTPUT: 01:10:51 INFO - 2015-11-18 01:10:51,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39395/tests/kraken/driver.html?testName=imaging-desaturate) 01:10:52 INFO - 2015-11-18 01:10:52,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 155635712 01:10:52 INFO - 2015-11-18 01:10:52,414 DEBUG : BROWSER_OUTPUT: 01:10:55 INFO - 2015-11-18 01:10:55,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39395/tests/kraken/driver.html?testName=json-parse-financial) 01:10:55 INFO - 2015-11-18 01:10:55,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 158023680 01:10:55 INFO - 2015-11-18 01:10:55,757 DEBUG : BROWSER_OUTPUT: 01:10:57 INFO - 2015-11-18 01:10:57,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:10:57 INFO - 2015-11-18 01:10:57,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 167104512 01:10:57 INFO - 2015-11-18 01:10:57,898 DEBUG : BROWSER_OUTPUT: 01:10:59 INFO - 2015-11-18 01:10:59,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:11:00 INFO - 2015-11-18 01:11:00,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 166658048 01:11:00 INFO - 2015-11-18 01:11:00,280 DEBUG : BROWSER_OUTPUT: 01:11:02 INFO - 2015-11-18 01:11:02,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:02 INFO - 2015-11-18 01:11:02,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 174366720 01:11:02 INFO - 2015-11-18 01:11:02,885 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-18 01:11:05,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:11:05 INFO - 2015-11-18 01:11:05,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 182005760 01:11:05 INFO - 2015-11-18 01:11:05,870 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-18 01:11:08,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:11:08 INFO - 2015-11-18 01:11:08,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 179601408 01:11:08 INFO - 2015-11-18 01:11:08,934 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39395/tests/kraken/driver.html?testName=ai-astar) 01:11:10 INFO - 2015-11-18 01:11:10,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 238792704 01:11:10 INFO - 2015-11-18 01:11:10,850 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,851 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:11:10 INFO - 2015-11-18 01:11:10,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:11:10 INFO - 2015-11-18 01:11:10,852 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:11:10 INFO - 2015-11-18 01:11:10,852 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:11:10 INFO - 2015-11-18 01:11:10,852 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;111;111;113;98;110;115;111 01:11:10 INFO - 2015-11-18 01:11:10,852 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;126;153;169;127;147;157;126;168;131 01:11:10 INFO - 2015-11-18 01:11:10,852 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;160;162;162;161;161;161;166;162;164 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;94;73;71;73;108;95;72 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;131;89;91;91;131;90;89;132 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;110;109 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;146;145;145 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;96;95;95;95;96 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;58;57;58;58;61;66;55;58 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;69;69;69;70 01:11:10 INFO - 2015-11-18 01:11:10,853 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;85;85;83;84;84;84;86;85 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;120;115;114;121;116;118;130;118;116 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;146;146;148;148;137;146;144;146;135 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;67;69;64;67;64;67;65;65 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837870850__endTimestamp 01:11:10 INFO - 2015-11-18 01:11:10,854 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:4.74 (4.3%) stddev-sans-first:5.02 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 111.0 111.0 113.0 98.0 110.0 115.0 111.0 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,858 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.30 Median:151.00 stddev:16.91 (11.2%) stddev-sans-first:17.88 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: Values: 149.0 126.0 153.0 169.0 127.0 147.0 157.0 126.0 168.0 131.0 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.83 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: Values: 164.0 160.0 162.0 162.0 161.0 161.0 161.0 166.0 162.0 164.0 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:13.43 (18.4%) stddev-sans-first:13.91 01:11:10 INFO - 2015-11-18 01:11:10,859 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 94.0 73.0 71.0 73.0 108.0 95.0 72.0 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:90.00 stddev:19.91 (22.1%) stddev-sans-first:20.68 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 131.0 89.0 91.0 91.0 131.0 90.0 89.0 132.0 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 01:11:10 INFO - 2015-11-18 01:11:10,860 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:2.94 (5.1%) stddev-sans-first:3.11 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 58.0 57.0 58.0 58.0 61.0 66.0 55.0 58.0 01:11:10 INFO - 2015-11-18 01:11:10,861 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.37 (1.6%) stddev-sans-first:0.88 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 85.0 85.0 83.0 84.0 84.0 84.0 86.0 85.0 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.00 stddev:4.62 (3.9%) stddev-sans-first:4.82 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: Values: 116.0 120.0 115.0 114.0 121.0 116.0 118.0 130.0 118.0 116.0 01:11:10 INFO - 2015-11-18 01:11:10,862 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:146.00 stddev:5.28 (3.6%) stddev-sans-first:4.72 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: Values: 135.0 146.0 146.0 148.0 148.0 137.0 146.0 144.0 146.0 135.0 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.94 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 67.0 69.0 64.0 67.0 64.0 67.0 65.0 65.0 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:11:10 INFO - 2015-11-18 01:11:10,863 DEBUG : BROWSER_OUTPUT: 01:11:11 INFO - 2015-11-18 01:11:11,713 INFO : Browser exited with error code: 0 01:11:11 INFO - 2015-11-18 01:11:11,767 INFO : Completed test kraken (00:00:58) 01:11:11 INFO - 2015-11-18 01:11:11,767 INFO : Starting test v8_7 01:11:11 INFO - 2015-11-18 01:11:11,767 DEBUG : operating with platform_type : linux_ 01:11:11 INFO - 2015-11-18 01:11:11,767 INFO : Initialising browser for v8_7 test... 01:11:11 INFO - 2015-11-18 01:11:11,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpboGSnk/profile http://localhost:39395/getInfo.html 01:11:15 INFO - 2015-11-18 01:11:15,548 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:11:15 INFO - 2015-11-18 01:11:15,548 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:11:15 INFO - 2015-11-18 01:11:15,548 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:11:15 INFO - 2015-11-18 01:11:15,548 DEBUG : BROWSER_OUTPUT: __metrics 01:11:15 INFO - 2015-11-18 01:11:15,690 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:16 INFO - 2015-11-18 01:11:16,892 INFO : Browser initialized. 01:11:16 INFO - 2015-11-18 01:11:16,893 INFO : Running cycle 1/1 for v8_7 test... 01:11:16 INFO - 2015-11-18 01:11:16,893 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpboGSnk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:11:28 INFO - 2015-11-18 01:11:28,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 01:11:28 INFO - 2015-11-18 01:11:28,662 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39395/tests/v8_7/run.html (next: http://localhost:39395/tests/v8_7/run.html) 01:11:50 INFO - 2015-11-18 01:11:50,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 627793920 01:11:50 INFO - 2015-11-18 01:11:50,322 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,322 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:11:50 INFO - 2015-11-18 01:11:50,322 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:11:50 INFO - 2015-11-18 01:11:50,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:11:50 INFO - 2015-11-18 01:11:50,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:11:50 INFO - 2015-11-18 01:11:50,323 DEBUG : BROWSER_OUTPUT: |0;Richards;162.89297931259162 01:11:50 INFO - 2015-11-18 01:11:50,323 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 01:11:50 INFO - 2015-11-18 01:11:50,323 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.9002849002849 01:11:50 INFO - 2015-11-18 01:11:50,325 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 01:11:50 INFO - 2015-11-18 01:11:50,325 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1098.901098901099 01:11:50 INFO - 2015-11-18 01:11:50,325 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 01:11:50 INFO - 2015-11-18 01:11:50,325 DEBUG : BROWSER_OUTPUT: |6;Boyer;11894.117647058823 01:11:50 INFO - 2015-11-18 01:11:50,326 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 01:11:50 INFO - 2015-11-18 01:11:50,326 DEBUG : BROWSER_OUTPUT: |8;Splay;646.8305304010349 01:11:50 INFO - 2015-11-18 01:11:50,326 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 01:11:50 INFO - 2015-11-18 01:11:50,326 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:11:50 INFO - 2015-11-18 01:11:50,326 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837910321__endTimestamp 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.89 Median:162.89 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,327 DEBUG : BROWSER_OUTPUT: Values: 162.9 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: Values: 194.4 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.90 Median:284.90 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: Values: 284.9 01:11:50 INFO - 2015-11-18 01:11:50,328 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: Values: 5035.2 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: Values: 1098.9 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,329 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: Values: 783.7 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11894.12 Median:11894.12 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: Values: 11894.1 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,330 DEBUG : BROWSER_OUTPUT: Values: 25666.7 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.83 Median:646.83 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: Values: 646.8 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: Values: 4830.9 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:11:50 INFO - 2015-11-18 01:11:50,331 DEBUG : BROWSER_OUTPUT: 01:11:51 INFO - 2015-11-18 01:11:51,205 INFO : Browser exited with error code: 0 01:11:51 INFO - 2015-11-18 01:11:51,222 INFO : Completed test v8_7 (00:00:39) 01:11:51 INFO - 2015-11-18 01:11:51,348 INFO : Completed test suite (00:20:12) 01:11:51 INFO - 2015-11-18 01:11:51,348 DEBUG : Working with test: dromaeo_css 01:11:51 INFO - 2015-11-18 01:11:51,348 DEBUG : Generating results file: dromaeo_css 01:11:51 INFO - 2015-11-18 01:11:51,350 DEBUG : Working with test: kraken 01:11:51 INFO - 2015-11-18 01:11:51,350 DEBUG : Generating results file: kraken 01:11:51 INFO - 2015-11-18 01:11:51,350 INFO : javascript benchmark 01:11:51 INFO - 2015-11-18 01:11:51,350 DEBUG : Working with test: v8_7 01:11:51 INFO - 2015-11-18 01:11:51,350 DEBUG : Generating results file: v8_7 01:11:51 INFO - 2015-11-18 01:11:51,351 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:51 INFO - 2015-11-18 01:11:51,400 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 01:11:51 INFO - 2015-11-18 01:11:51,400 DEBUG : process_Request line: dromaeo_css 6807.92 graph.html#tests=[[72,201,35]] 01:11:51 INFO - 2015-11-18 01:11:51,400 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:51 INFO - 2015-11-18 01:11:51,428 DEBUG : process_Request line: kraken 1489.10 graph.html#tests=[[232,201,35]] 01:11:51 INFO - 2015-11-18 01:11:51,429 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:51 INFO - 2015-11-18 01:11:51,458 DEBUG : process_Request line: v8_7 21000.41 graph.html#tests=[[230,201,35]] 01:11:51 INFO - 2015-11-18 01:11:51,459 INFO : javascript benchmark 01:11:51 INFO - 2015-11-18 01:11:51,461 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [363.07778243262135, 363.24807648168303, 363.73447383410104, 366.6168853548042, 368.7179307829511, 14379.784303235434, 15049.0, 16730.498085057454, 17600.38398656047, 18319.0, 16627.66744665106, 16692.499225023268, 16799.496015119534, 16889.23998420071, 17029.318827246927, 5134.845954621367, 5237.10969135246, 5268.578513718893, 5269.0, 5270.631055826094, 3838.0788610733503, 3950.881473555798, 5307.150855863063, 5866.178734977086, 6040.426159514839, 5946.613470124428, 5951.0, 5969.343372229051, 5975.701214939258, 5982.43166899146, 5735.942640573603, 5901.822945311647, 5903.085021821625, 5910.202122713443, 5913.645181289094, 5211.530962213419, 5215.0, 5217.217417387422, 5221.921671174935, 5222.138347172712, 13249.0, 13359.398827052708, 13448.1258718183, 13577.321133943264, 13589.116707413987, 1812.2932056497975, 1967.498287936567, 2037.4397040813894, 2098.6432306507777, 2125.0649714125734, 9975.800483990351, 10112.63758017262, 10224.079832815083, 10245.538950747234, 10347.844782328271, 1623.1721821870813, 1691.798822835788, 1713.20336043739, 1713.6658351621438, 1736.9565760855953, 57476.42523574753, 58780.41219587835, 58908.11637825436, 59576.70211648957, 59980.100298495556, 7058.082449281561, 7119.4660400470175, 7147.785566433015, 7151.89272160918, 7182.8204294892, 8515.27620152294, 8519.148085191431, 8523.531205783618, 8554.957225213833, 8576.914230857736, 5786.450287222707, 5826.41735826414, 5836.620619659709, 5860.794872179454, 5871.588988770745, 6146.078088286703, 6152.323244443108, 6158.445739883432, 6190.380961903774, 6202.844928876724, 3344.414727422691, 3349.9330013399594, 3376.594808622981, 3388.8136152511847, 3404.38721030212, 1061.7186445591924, 1128.5147386623667, 1172.3786393211612, 1175.400545721688, 1217.3000524698334, 415.8045718512294, 423.74151767421847, 426.3115069163279, 499.61030396290954, 503.25769490001954, 10535.894641053492, 10827.891721082846, 10983.176261780398, 11029.0, 11075.833862492069, 448.92143874822426, 449.0816280705964, 449.1062785057712, 464.0162854747956, 464.52154281089855, 5845.473907348359, 5899.852503687356, 5919.763209471659, 6047.304559975659, 6054.061620448838, 560065.0, 560357.0, 563004.0, 570842.0, 574017.0, 71127.64436177786, 71532.64233678798, 72299.0, 73673.63163184257, 73987.0, 504.25873965270995, 512.2086376548242, 513.194284972597, 513.5301199402505, 514.3236643813299, 9862.901370986197, 9965.750856228653, 10108.292419530562, 10164.288499804943, 10239.897601023895, 33609.15977100494, 33688.0, 34109.65890341065, 34654.306913862085, 34730.479042814884, 46246.768766155954, 46840.297395539776, 47034.764826177015, 47373.7631311855, 48070.75964620154, 6794.966025169842, 6836.692348844214, 6852.45180385558, 6895.069165662772, 6895.172579290517, 12266.938665306616, 12520.123591348518, 12844.743105138032, 12853.293068881301, 12872.806907896576, 8976.685815996409, 9235.630574776933, 9385.202257808163, 11204.83192752093, 11244.325340479598, 9881.357711748713, 10235.334703244265, 10426.27016108865, 10466.63366782159, 10613.628523001658, 9059.728208153765, 9274.489903055397, 10481.161507079567, 10556.84164737545, 10784.838227426439, 14635.85364146345, 14822.184779836782, 14915.179665118523, 15079.24603769829, 15211.923940380228, 14791.334389952694, 15768.053916765031, 15817.525474235792, 16118.919405403367, 16644.0], "dojo.html": [3190.154609028608, 3211.7591180661457, 3277.1151789016967, 3290.3912776136417, 3300.0, 5102.413222479416, 5216.843494695156, 5376.64825484737, 5394.406615272322, 5458.099413596757, 5321.467853214676, 5337.7598008089635, 5403.351597808259, 5408.756605952732, 5417.45825417458, 4847.927281090787, 4884.853454396365, 4969.105560999019, 5062.392512898457, 5097.643164978453, 4824.493428190042, 5036.445990940993, 5057.620678449112, 5078.59371250301, 5101.6683915545555, 4908.950910490921, 4943.555080042795, 5026.8240611578785, 5068.138416469209, 5084.034033533654, 4923.827666031708, 4935.851924442272, 4967.081089998325, 4975.0, 5038.571721403685, 4795.520447955211, 4896.534829191221, 4971.8259860905055, 4993.850184494471, 5028.34631497903, 5059.06407314648, 5166.560842328407, 5170.0, 5175.715335656538, 5199.194124910645, 5819.272590926134, 5834.737436815311, 5835.0, 5857.736401861926, 5879.176915231871, 5726.055200891848, 5786.594938354317, 5823.592348535604, 5894.675792831393, 5905.29136503618, 5531.778728850841, 5539.806106786243, 5542.75057622408, 5544.002079625666, 5545.61180717354, 5985.610935289193, 6002.489788368038, 6013.278406591237, 6016.789412370546, 6060.878782424327, 5514.420985796433, 5617.129344951539, 5671.602987790815, 5806.738696758656, 5808.5062769665055, 5776.277965254343, 5783.0, 5785.190073389729, 5791.913121303184, 5794.82615521535, 5759.164921086419, 5768.423157684282, 5771.6537007778825, 5775.27809023872, 5776.826695199151, 5630.5495560355075, 5643.40744221859, 5712.285964254468, 5762.625429347079, 5772.826815195467, 4486.484054333728, 4529.592336689714, 4530.207213737583, 4530.637548996073, 4568.588827005586, 3940.408938659167, 4030.1939612077704, 4033.032072302626, 4045.9797701011894, 4062.918741625151, 5468.644538105011, 5472.452754724496, 5532.031894418461, 5559.749811258423, 5582.944170558242, 5828.0966450200285, 5830.154627578977, 5835.649861008353, 5835.824925252249, 5839.591228613956, 5392.91910621341, 5517.144842549411, 5524.1989911462615, 5527.336719593674, 5540.445955404508, 4901.681390709592, 4940.481249468826, 5027.3464449621315, 5033.295338652519, 5073.822416215488, 5984.970075149684, 5991.101334799728, 5993.130996005555, 5996.4603185713495, 5998.850028749229, 5682.403347648437, 5814.331351894586, 5814.622049566765, 5821.417858214145, 5835.037218858841, 5936.673482958306, 6034.275886893601, 6034.39656034393, 6075.696215189135, 6085.391460853879, 5773.24947756789, 5774.133879918046, 5775.451332123442, 5776.133579963039, 5783.450572195635, 5465.945340546544, 5580.2466666999435, 5847.619904706181, 5867.413258674099, 5870.17817505541, 5566.77732890696, 5587.413321601173, 5591.329040515164, 5591.524720398812, 5593.888122237451, 5514.751836167462, 5547.750351234124, 5547.972260138674, 5549.084401073939, 5559.8888022240135, 5497.202905578749, 5497.312835895513, 5521.337439507285, 5621.775128994795, 5662.603617746719, 5725.456081672234, 5779.913301300399, 5815.982203114353, 5828.0, 5879.265091863517, 5680.346760122474, 5688.061469857593, 5694.373618901835, 5698.715064246854, 5703.486686198262], "mootools.html": [1372.629390064683, 1718.3212631010751, 1769.27459741506, 1791.1581556668361, 1804.260253296149, 6678.465722742181, 7367.5211111277795, 7535.397168226543, 7548.282913123258, 7549.50928189668, 7703.807404814883, 7822.335101516378, 7825.452218344718, 7825.804354891131, 7864.056313242405, 2038.8368930485526, 2092.06902928197, 2272.9659055114143, 2280.726312842453, 2285.325828880476, 2336.3925379401394, 2340.8595484271, 2341.3444235614056, 2341.4146463384154, 2343.425860664131, 2258.0741895822716, 2346.378209774411, 2348.7886090251873, 2350.2831636350907, 2352.3531028967, 2036.6028624418245, 2086.019570801721, 2283.748787633359, 2323.256557901472, 2324.23300310897, 2318.2465698648007, 2325.476767727265, 2351.4356554426813, 2352.3413444235644, 2371.5968285391523, 7812.765617031499, 7816.921830781676, 7866.960665196694, 7878.1727918568295, 7879.684812607489, 4797.640176986705, 4883.072216278895, 4906.386701662293, 4906.632002599819, 4911.238757992517, 3145.3866496033284, 3149.889753858627, 3188.3304506053755, 3254.8535315910603, 3276.9836150819333, 1030.6135199300263, 1047.036805988771, 1053.973650658732, 1083.409541799721, 1091.0671375973586, 10788.406637634927, 10811.459427028696, 10817.080548153417, 10817.621383251548, 10861.782764344747, 4347.282698354736, 4391.802368893344, 4492.640588752892, 4499.392582001388, 4503.054358584734, 9193.0, 9209.35534512591, 9212.447253164832, 9217.95391023054, 9223.077692230723, 4883.340748998839, 4916.852494425101, 4948.1835497142565, 4948.851534453972, 4953.925691114636, 4429.335599660077, 4476.239039363316, 4513.526079761644, 4519.570640789119, 4520.208963431386, 3714.7399682022, 3718.572364178154, 3731.552213734369, 3741.6819570336825, 3760.247950409874, 1241.4847838147068, 1254.736505333872, 1256.8303279057393, 1258.314218750783, 1263.5577547858177, 1008.1682611845257, 1039.1998161415668, 1285.3380509037852, 1313.382710126239, 1325.185011218094, 7371.741989030358, 7565.773026809205, 7596.430267729832, 7634.770956871303, 7653.425993050543, 703.409136325489, 704.9118860142482, 710.5381502023725, 721.7401735375261, 730.0545793197822, 5866.67733274674, 5913.172155898178, 5915.704214789243, 5916.26046744157, 5927.288725352985, 9183.77040573991, 9320.254379649612, 9448.385854919547, 9488.098630630078, 9643.662471813454, 9453.71638850822, 9503.524823758922, 9503.57233924475, 9504.42973421597, 9511.381760185566, 6930.514863959575, 7071.080759501335, 7135.78592642232, 7363.079615048119, 7407.111146662435, 7368.078990126234, 7402.555846649218, 7409.296116868889, 7424.740134095281, 7434.7769566913075, 8235.876461853197, 8375.539345336065, 8475.915240847758, 8511.021232558087, 8601.569921504026, 8678.956605216934, 8783.385163038525, 8798.516081615573, 8812.030676625438, 8826.470411775057, 6876.553024053421, 7128.394086502705, 7156.463265255231, 7161.677724502514, 7169.856602867809, 7648.08223013242, 7649.235076492307, 7658.617069146632, 7666.4633475656165, 7666.655000525101, 6931.133608298963, 6980.127484064492, 7149.356557909605, 7238.457115716237, 7283.8543229136185, 6954.3393377629045, 7032.296770322927, 7048.577085374894, 7069.82325441868, 7076.150861896605, 7178.4257259420165, 7205.927940720735, 7211.71153153868, 7244.4566657499845, 7256.96371518139, 6362.395572420613, 6430.807075787734, 6478.935210647834, 6494.383033611799, 6504.317046710027, 6452.870942581216, 6484.416402523795, 6731.966340168267, 6732.124823772878, 6744.494162937897], "ext.html": [555.9048674112, 588.6821116597038, 600.5345856960855, 606.4329851588767, 623.1742940603701, 31673.68326316736, 32641.0, 40118.598814011886, 40436.0, 40589.0, 43970.34044489335, 44257.33613995793, 44353.77823110888, 44371.33442998349, 44469.77765111178, 8720.345974051956, 8888.555572221396, 8902.332325075646, 8903.732888013337, 8906.821863562725, 7635.312821846032, 7890.132085470594, 10490.842637360445, 10753.56985720574, 10758.78482430351, 10472.528736206888, 10511.84232236517, 10569.788604227911, 10582.894171058268, 10591.523381447852, 7746.0, 10446.164306855471, 10508.579656813794, 10526.526306316235, 10551.155907527418, 7621.085469743666, 10549.0, 10747.892521074768, 10819.78360432787, 10829.729256768565, 40245.0, 40667.389989150186, 40676.59323406758, 40706.796466017775, 40802.38796418056, 3344.6488118747425, 3408.1820363112674, 3735.2716220337047, 3949.7037722170667, 4065.3292206785845, 30245.697543024507, 30462.086137415914, 30472.8476357619, 30809.537856932166, 31649.683503164903, 3535.744810592254, 3568.982155089234, 3589.10272431892, 3598.478220658016, 3718.3864662330684, 285144.0, 285587.0, 285701.0, 285881.0, 286084.0, 53188.99999999923, 54065.0, 60223.69888150531, 60558.39441605616, 60637.69681151566, 68607.0, 69741.0, 70162.64918675374, 70248.0, 70294.0, 14587.05184163026, 14817.70364592702, 14860.405583776745, 14908.925455372872, 14921.776173357408, 11758.235714678689, 11847.76304473923, 11853.940730296294, 11889.643310700692, 11891.227070240408, 19509.8049019508, 19573.51066223356, 19608.313709020116, 19638.0, 19992.800071999383, 7818.843623127505, 8020.19798020205, 8158.510489370657, 8262.876056859152, 8276.172382761795, 860.8149247911729, 925.287528602972, 937.5968333616474, 993.7813680990171, 1065.79217052674, 26024.86987565088, 26397.47205055888, 26454.33864153373, 28851.42297154045, 29863.701362986092, 992.6523771281013, 1025.7692019295748, 1084.5173897615643, 1153.9711507212219, 1155.5320095361392, 13585.864141358657, 13633.590992270249, 13699.109557878706, 13765.38055787492, 13810.240436776074, 341254.0, 346660.0, 346660.0, 346664.0, 348024.0, 51869.7406512965, 51879.48120518746, 52176.739116304176, 52435.47564524306, 52513.2123018155, 1285.5629086110766, 1354.2416246901766, 1361.4077876123918, 1366.631009627395, 1378.9034767566375, 27265.31836704098, 28273.717262827107, 28322.0, 28558.286042849097, 29582.260443489085, 48326.51673483361, 49252.507474924794, 55206.44793552174, 56372.43627563672, 56408.15387769269, 282820.0, 283714.0, 284462.0, 284929.0, 286300.0, 27740.0, 28156.85921570461, 31330.843345783127, 31709.20726981844, 31758.206044849063, 44131.338029928935, 44229.115417690824, 44296.77851610721, 44446.55553444424, 44683.329750053126, 36027.63972360243, 36593.45109823408, 36620.0, 36818.263634726616, 37083.0, 35038.0, 36553.63446365609, 36600.81699591485, 37583.43624845684, 38703.61296387, 35381.1154721134, 36628.0, 36748.44877326896, 36813.26373472569, 36879.07802304964, 29769.404611908074, 32985.897608942425, 33646.0, 33657.663423365455, 33663.3267334647, 23843.284701458982, 24281.150159744324, 24412.0, 24704.505909881344, 24916.626250605892], "prototype.html": [339.11998364244783, 345.832271348396, 347.4440894568689, 349.3885700024956, 356.937535931212, 5968.9701551492235, 6012.909806352908, 6044.939550604498, 6065.545084118698, 6093.4211249931295, 5767.336756273019, 5788.82633520995, 5893.469587737103, 5975.760969561224, 5991.670458124812, 4628.768561571925, 4649.744264065492, 4651.0, 4661.347411362412, 4663.60359369454, 4401.207782599131, 4665.556772106662, 4673.556012178855, 4673.672842900998, 4680.719156850583, 4434.844780432685, 4507.0, 4605.171069207541, 4608.654350923694, 4640.60554852838, 4596.0, 4599.310103484488, 4606.654500912411, 4615.261558150713, 4620.607248383892, 4068.6541643960004, 4077.347624380085, 4081.6326530612387, 4090.6931980101613, 4093.2836753568304, 5560.2493663355335, 5682.431756824326, 5682.488576028136, 5685.204071430003, 5691.459311365414, 5285.973570132125, 5298.470152984709, 5313.442088580682, 5320.0, 5333.413324534337, 6369.108324834527, 6369.681515924185, 6372.553921225516, 6374.808755737289, 6385.393387628168, 4248.745075295492, 4351.129774045204, 4360.258756011485, 4431.867043988654, 4458.063806600618, 6530.6734663267125, 6570.770023049218, 6584.078229047937, 6595.835104122388, 6613.173353330833, 4539.75031373271, 4540.750258735801, 4542.295944128666, 4547.704399214041, 4550.408446901948, 4507.729536227836, 4592.425946756655, 4593.150267200579, 4594.081183763261, 4595.4025976622825, 5299.549538289211, 5311.415744268127, 5324.946750532523, 5325.813596524103, 5327.121025030904, 6429.6463694496315, 6429.742810287629, 6436.581622194542, 6438.903416448757, 6440.806775796734, 1602.6954878573033, 1603.4067395063669, 1603.871690264776, 1604.1498006056809, 1605.8715302775984, 1033.421284080902, 1068.9679309620724, 1077.472038701031, 1089.629525961161, 1120.047959234644, 6208.844778880474, 6233.501319894398, 6235.0, 6238.970569856014, 6252.718627661675, 6540.2805691373915, 6589.670516474157, 6590.044443555657, 6594.8351291218105, 6600.339966003457, 6087.981931924908, 6190.659513726789, 6236.501079913596, 6246.531510136758, 6251.28110267316, 3548.2193917338145, 3576.5886923004186, 3579.1410061585034, 3580.588232353313, 3583.605803361628, 6812.4550035997, 6813.807583672838, 6826.795196144024, 6830.282820303796, 6837.179538455417, 6641.970494573349, 6768.661566921634, 6768.763093291711, 6779.966100169468, 6784.626845523544, 6780.7287708492095, 6811.863762724817, 6817.829554261183, 6820.249772525019, 6824.556403833834, 6574.112494813139, 6577.046328282468, 6580.7038683260325, 6583.835404114935, 6603.240627327918, 6353.523485738496, 6354.1104245406605, 6496.7726129585235, 6578.5395022347975, 6580.967095164685, 6835.316468353324, 6864.313568643096, 6876.5186436950935, 6887.414569761627, 6894.724211031503, 4543.45478542577, 4566.725996440225, 4568.680192386501, 4578.702384345007, 4582.656300777388, 6461.935380646133, 6495.285518593046, 6629.535932484872, 6653.434458071119, 6701.765438209639, 6506.121673574007, 6509.804705858832, 6512.73949042033, 6513.706883190173, 6518.641474718936, 6487.805365839033, 6499.707513161825, 6505.837354066186, 6508.186476690414, 6510.967445162744, 6202.596831205957, 6353.841153971188, 6358.205224346957, 6368.77709280173, 6372.107904893226, 6443.226812782309, 6492.415682588589, 6500.382463665944, 6502.967485162544, 6513.706883190173, 6171.938280617136, 6341.048842673451, 6341.90487142684, 6352.110704501466, 6358.427741503102], "yui.html": [844.1642773654081, 846.7036537211976, 857.4855086947828, 858.7380848841101, 886.1537231943495, 13251.536196233134, 13483.056186066968, 13487.730245395087, 13502.189868607891, 13508.121972071809, 13298.800517992238, 13378.531751388704, 13385.66535836602, 13388.799168012487, 13406.061575689706, 684.907537482441, 692.9826754331157, 818.3698552114882, 833.1834801894117, 833.6665333866472, 828.888100106487, 829.9585020748939, 830.4353039932844, 832.5545832979358, 838.4717627894418, 870.9259712924409, 888.3381880499005, 888.995555022224, 889.0798024045115, 889.1375365895071, 720.8846584546474, 726.3172617739308, 867.2974890338783, 876.2814492116468, 878.1043335797483, 644.0789670770796, 647.5920170292733, 648.044134901022, 648.4293821437152, 649.2436311696868, 13636.93181534086, 13754.105983111165, 13763.793543096861, 13790.931045344809, 13795.379207935666, 11931.164818462712, 12484.50061997519, 12501.187422817487, 12632.873671263262, 13234.801477977839, 10326.173906087495, 10383.740406489898, 10450.843237351446, 10461.843072353844, 10627.84058239127, 3314.6188188358165, 3341.081202669261, 3373.3590617782543, 3429.2798512312443, 3429.4684323929832, 44005.77997110026, 45907.311390329174, 46134.0, 46143.0, 46145.53854461479, 7479.8504029919095, 7644.788412947823, 7754.340881025063, 7888.290053895177, 7894.486858354188, 11750.882491174978, 11752.764944701059, 11775.764484710258, 11785.941070294593, 11797.823032654516, 6712.42944349726, 6788.422984046312, 6821.113255276881, 6978.162620485574, 7088.0785497884945, 4292.7424354538825, 4300.741955482681, 4343.326784348431, 4379.3649920761945, 4401.735895846259, 2847.373577812878, 2864.627598412193, 2864.9856750716112, 2873.6264285642733, 2881.423715256957, 474.71517089745873, 476.1358134984991, 479.1136397664363, 487.3177551428029, 488.4334172360045, 642.4924309795302, 674.2280089297825, 693.9861202775916, 696.9303069692991, 708.4343600642637, 8863.468191908507, 9059.184673379428, 9238.307126965505, 9744.561494732754, 9810.117089461983, 594.6224147666263, 643.9420452159328, 705.2982282628817, 707.738136889344, 745.3776096958992, 4051.5948405159247, 4343.9348409773875, 4509.098180363875, 4531.365608814768, 4587.1513769952, 52184.47815521872, 52797.0, 53034.46965530295, 53269.0, 53399.733001335524, 46697.766511167225, 47068.05863882703, 47411.5258847414, 47522.28716569254, 47961.760191198824, 45035.0, 46474.302885456746, 46752.0, 47652.99999999931, 48002.759986199846, 8904.154105359981, 9015.639374424949, 9145.817083658423, 9281.535923203948, 9432.481213533321, 32918.506222406206, 34919.82540087283, 35199.82400087983, 36090.0, 36513.63486365102, 44055.779721101186, 44703.32945005762, 44931.32603010892, 45085.32372014488, 45263.09473810571, 8223.794405139919, 8312.25189732927, 8460.450070745383, 8493.87259191125, 8541.701040463802, 12058.819117713418, 12082.0, 12118.0, 12295.938520307342, 12495.625131246077, 11115.88884111181, 11340.432978351215, 11385.03227225662, 11734.0, 11740.354280514654, 11478.770424591294, 11684.649460516199, 12000.939995299968, 12216.755664886474, 12254.20347677398, 11166.44167791591, 11378.146639001943, 11469.992221214792, 11544.076473882238, 11745.17783755129, 9985.850212246967, 10155.695329140137, 10159.542820572944, 10234.948825255826, 10272.537735802056, 9302.720918372459, 9589.184919281939, 9725.693204807661, 9739.513024348613, 9744.561494732612]}, "summary": {"lowerIsBetter": false, "suite": 6807.916412016234, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7282.665137099272, "unit": "ms", "value": 7282.665137099272}, "dojo.html": {"lowerIsBetter": false, "filtered": 5358.986452855183, "unit": "ms", "value": 5358.986452855183}, "mootools.html": {"lowerIsBetter": false, "filtered": 4527.341943206035, "unit": "ms", "value": 4527.341943206035}, "ext.html": {"lowerIsBetter": false, "filtered": 18964.174907927776, "unit": "ms", "value": 18964.174907927776}, "prototype.html": {"lowerIsBetter": false, "filtered": 4832.667078156813, "unit": "ms", "value": 4832.667078156813}, "yui.html": {"lowerIsBetter": false, "filtered": 6147.675197388848, "unit": "ms", "value": 6147.675197388848}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-002"}, "testrun": {"date": 1447836699, "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": "20151117233002", "branch": "B2G-Inbound", "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 166.0, 162.0, 164.0], "ai-astar": [109.0, 110.0, 105.0, 111.0, 111.0, 113.0, 98.0, 110.0, 115.0, 111.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [149.0, 126.0, 153.0, 169.0, 127.0, 147.0, 157.0, 126.0, 168.0, 131.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [135.0, 146.0, 146.0, 148.0, 148.0, 137.0, 146.0, 144.0, 146.0, 135.0], "json-parse-financial": [59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 61.0, 66.0, 55.0, 58.0], "stanford-crypto-sha256-iterative": [66.0, 69.0, 67.0, 69.0, 64.0, 67.0, 64.0, 67.0, 65.0, 65.0], "audio-fft": [72.0, 73.0, 72.0, 94.0, 73.0, 71.0, 73.0, 108.0, 95.0, 72.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "stanford-crypto-ccm": [116.0, 120.0, 115.0, 114.0, 121.0, 116.0, 118.0, 130.0, 118.0, 116.0], "audio-oscillator": [91.0, 90.0, 131.0, 89.0, 91.0, 91.0, 131.0, 90.0, 89.0, 132.0], "stanford-crypto-aes": [81.0, 84.0, 85.0, 85.0, 83.0, 84.0, 84.0, 84.0, 86.0, 85.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.3, "unit": "ms", "value": 80.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.1, "unit": "ms", "value": 143.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.4, "unit": "ms", "value": 118.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.8, "unit": "ms", "value": 58.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.5, "unit": "ms", "value": 102.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.0, "unit": "ms", "value": 69.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "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-002"}, "testrun": {"date": 1447836699, "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": "20151117233002", "branch": "B2G-Inbound", "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.43904335990666], "Encrypt": [284.9002849002849], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [646.8305304010349], "Richards": [162.89297931259162], "RegExp": [25666.666666666668], "Earley": [783.6990595611285], "Boyer": [11894.117647058823], "RayTrace": [1098.901098901099]}, "summary": {"lowerIsBetter": false, "suite": 21000.410163375265, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.0448739999999, "unit": "score", "value": 340.0448739999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 934.2953100000001, "unit": "score", "value": 934.2953100000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 125.98508600000002, "unit": "score", "value": 125.98508600000002}, "RegExp": {"lowerIsBetter": false, "filtered": 35.49292207792205, "unit": "score", "value": 35.49292207792205}, "Richards": {"lowerIsBetter": false, "filtered": 216.71897800000008, "unit": "score", "value": 216.71897800000008}, "Earley": {"lowerIsBetter": false, "filtered": 850.4067880000003, "unit": "score", "value": 850.4067880000003}, "Boyer": {"lowerIsBetter": false, "filtered": 56.0329920870425, "unit": "score", "value": 56.0329920870425}, "RayTrace": {"lowerIsBetter": false, "filtered": 673.3899900000001, "unit": "score", "value": 673.3899900000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-002"}, "testrun": {"date": 1447836699, "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": "20151117233002", "branch": "B2G-Inbound", "revision": "7dba29b2ea55f6b26b42046c73b511bb89753934"}}] 01:11:51 INFO - RETURN: dromaeo_css: 6807.92 01:11:51 INFO - RETURN: kraken: 1489.10 01:11:51 INFO - RETURN: v8_7: 21000.41 01:11:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21000.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1489.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6807.92"}}} 01:11:51 INFO - Return code: 0 01:11:51 INFO - # TBPL SUCCESS # 01:11:51 INFO - Running post-action listener: _resource_record_post_action 01:11:51 INFO - Running post-run listener: _resource_record_post_run 01:11:52 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 509349888; Read time: 0; Write time: 418488 01:11:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 175149056; Read time: 0; Write time: 164428 01:11:52 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 330252288; Read time: 0; Write time: 253792 01:11:52 INFO - Running post-run listener: _upload_blobber_files 01:11:52 INFO - Blob upload gear active. 01:11:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:11:52 INFO - Copying logs to upload dir... 01:11:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.901789 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 01:11:51.546258) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 01:11:51.550246) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/MbsHRxciQ-qhVPcArJArAA/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-18 01:11:51.601542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 01:11:51.601892) ========= 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=dd132779db58144225c4cf24000001c8-1447827096.822589-272540105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 01:11:51.651736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 01:11:51.652081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 01:11:51.652397) ========= ========= Total master_lag: 0.22 =========