builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1457710065.87 results: success (0) buildid: 20160311043041 builduid: d8c02e9ab06e4f0dbd5e3a081490d7cb revision: f30fc906416f25adf1fff45ff2466ddaaaec23c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.870468) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.870973) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.871267) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006293 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.892144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.892437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.906179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.906459) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.955248) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.955531) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.955875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:45.956144) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 07:27:46-- 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% 226M=0s 2016-03-11 07:27:46 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.122215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.122529) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.171389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.171747) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f30fc906416f25adf1fff45ff2466ddaaaec23c4 --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/mozilla-inbound --rev f30fc906416f25adf1fff45ff2466ddaaaec23c4 --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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 07:27:46,369 truncating revision to first 12 chars 2016-03-11 07:27:46,369 Setting DEBUG logging. 2016-03-11 07:27:46,369 attempt 1/10 2016-03-11 07:27:46,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f30fc906416f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 07:27:46,780 unpacking tar archive at: mozilla-inbound-f30fc906416f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.862668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.863042) ========= echo f30fc906416f25adf1fff45ff2466ddaaaec23c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f30fc906416f25adf1fff45ff2466ddaaaec23c4'] 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f30fc906416f25adf1fff45ff2466ddaaaec23c4 program finished with exit code 0 elapsedTime=0.003939 script_repo_revision: 'f30fc906416f25adf1fff45ff2466ddaaaec23c4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.912133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.912435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:46.923364) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-11 07:27:46.923663) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:47 INFO - MultiFileLogger online at 20160311 07:27:47 in /builds/slave/test-pgo 07:27:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:27:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:27:47 INFO - {'append_to_log': False, 07:27:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:27:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:27:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:27:47 INFO - 'branch': 'Mozilla-Inbound', 07:27:47 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:47 INFO - 'config_files': ('talos/linux_config.py',), 07:27:47 INFO - 'default_actions': ('clobber', 07:27:47 INFO - 'read-buildbot-config', 07:27:47 INFO - 'download-and-extract', 07:27:47 INFO - 'populate-webroot', 07:27:47 INFO - 'create-virtualenv', 07:27:47 INFO - 'install', 07:27:47 INFO - 'run-tests'), 07:27:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:47 INFO - 'download_minidump_stackwalk': True, 07:27:47 INFO - 'download_symbols': 'ondemand', 07:27:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:47 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:47 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:47 INFO - 'installer_path': 'installer.exe', 07:27:47 INFO - 'log_level': 'info', 07:27:47 INFO - 'log_name': 'talos', 07:27:47 INFO - 'log_to_console': True, 07:27:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:47 INFO - 'opt_config_files': (), 07:27:47 INFO - 'pip_index': False, 07:27:47 INFO - 'sps_profile': False, 07:27:47 INFO - 'sps_profile_interval': 0, 07:27:47 INFO - 'suite': 'dromaeojs-e10s', 07:27:47 INFO - 'system_bits': '32', 07:27:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:47 INFO - 'title': 'talos-linux64-ix-014', 07:27:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:47 INFO - 'use_talos_json': True, 07:27:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:27:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:47 INFO - 'work_dir': 'build'} 07:27:47 INFO - ##### 07:27:47 INFO - ##### Running clobber step. 07:27:47 INFO - ##### 07:27:47 INFO - Running pre-action listener: _resource_record_pre_action 07:27:47 INFO - Running main action method: clobber 07:27:47 INFO - rmtree: /builds/slave/test-pgo/build 07:27:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:27:47 INFO - Running post-action listener: _resource_record_post_action 07:27:47 INFO - ##### 07:27:47 INFO - ##### Running read-buildbot-config step. 07:27:47 INFO - ##### 07:27:47 INFO - Running pre-action listener: _resource_record_pre_action 07:27:47 INFO - Running main action method: read_buildbot_config 07:27:47 INFO - Using buildbot properties: 07:27:47 INFO - { 07:27:47 INFO - "project": "", 07:27:47 INFO - "product": "firefox", 07:27:47 INFO - "script_repo_revision": "production", 07:27:47 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:27:47 INFO - "repository": "", 07:27:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:27:47 INFO - "buildid": "20160311043041", 07:27:47 INFO - "pgo_build": "True", 07:27:47 INFO - "basedir": "/builds/slave/test-pgo", 07:27:47 INFO - "buildnumber": 766, 07:27:47 INFO - "slavename": "talos-linux64-ix-014", 07:27:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:27:47 INFO - "platform": "ubuntu64_hw", 07:27:47 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:27:47 INFO - "branch": "mozilla-inbound", 07:27:47 INFO - "repo_path": "integration/mozilla-inbound", 07:27:47 INFO - "revision": "f30fc906416f25adf1fff45ff2466ddaaaec23c4", 07:27:47 INFO - "stage_platform": "linux64-pgo", 07:27:47 INFO - "builduid": "d8c02e9ab06e4f0dbd5e3a081490d7cb", 07:27:47 INFO - "slavebuilddir": "test" 07:27:47 INFO - } 07:27:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:27:47 INFO - Running post-action listener: _resource_record_post_action 07:27:47 INFO - ##### 07:27:47 INFO - ##### Running download-and-extract step. 07:27:47 INFO - ##### 07:27:47 INFO - Running pre-action listener: _resource_record_pre_action 07:27:47 INFO - Running main action method: download_and_extract 07:27:47 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:27:47 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')]} 07:27:47 INFO - https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:27:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:27:48 INFO - Downloaded 1361 bytes. 07:27:48 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:48 INFO - Using the following test package requirements: 07:27:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:27:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:27:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'jsshell-linux-x86_64.zip'], 07:27:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:27:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:27:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:27:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:27:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:27:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:27:48 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')]} 07:27:48 INFO - https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:27:49 INFO - Downloaded 23403867 bytes. 07:27:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:27:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:27:50 INFO - Return code: 0 07:27:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:27:50 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')]} 07:27:50 INFO - https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:27:51 INFO - Downloaded 23403867 bytes. 07:27:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:27:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:27:53 INFO - Return code: 0 07:27:53 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')]} 07:27:53 INFO - https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:27:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:27:54 INFO - Downloaded 10845263 bytes. 07:27:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:27:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:27:54 INFO - Return code: 0 07:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:54 INFO - https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:27:56 INFO - Downloaded 56243895 bytes. 07:27:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:56 INFO - mkdir: /builds/slave/test-pgo/properties 07:27:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:27:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:27:56 INFO - Contents: 07:27:56 INFO - build_url:https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:56 INFO - Running post-action listener: _resource_record_post_action 07:27:56 INFO - Running post-action listener: set_extra_try_arguments 07:27:56 INFO - ##### 07:27:56 INFO - ##### Running populate-webroot step. 07:27:56 INFO - ##### 07:27:56 INFO - Running pre-action listener: _resource_record_pre_action 07:27:56 INFO - Running main action method: populate_webroot 07:27:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:56 INFO - '--tppagecycles', 07:27:56 INFO - '7'], 07:27:56 INFO - 'tests': ['tsvgm']}}, 07:27:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:27:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:27:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'tests': ['damp', 'tps']}, 07:27:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['damp', 'tps']}, 07:27:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:27:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:56 INFO - 'other': {'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'other_l64': {'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'other_nol64': {'tests': ['a11yr', 07:27:56 INFO - 'ts_paint', 07:27:56 INFO - 'tpaint', 07:27:56 INFO - 'sessionrestore', 07:27:56 INFO - 'sessionrestore_no_auto_restore', 07:27:56 INFO - 'tabpaint']}, 07:27:56 INFO - 'svgr': {'tests': ['tsvgx', 07:27:56 INFO - 'tsvgr_opacity', 07:27:56 INFO - 'tart', 07:27:56 INFO - 'tscrollx', 07:27:56 INFO - 'cart']}, 07:27:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['tsvgx', 07:27:56 INFO - 'tsvgr_opacity', 07:27:56 INFO - 'tart', 07:27:56 INFO - 'tscrollx', 07:27:56 INFO - 'cart']}, 07:27:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'tests': ['tp5o']}, 07:27:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'talos_options': ['--e10s'], 07:27:56 INFO - 'tests': ['tp5o']}, 07:27:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'talos_options': ['--xperf_path', 07:27:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:56 INFO - 'tests': ['tp5n']}, 07:27:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:56 INFO - 'talos_options': ['--e10s', 07:27:56 INFO - '--xperf_path', 07:27:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:56 INFO - 'tests': ['tp5n']}}, 07:27:56 INFO - 'talos.zip': {'path': '', 07:27:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:56 INFO - Running post-action listener: _resource_record_post_action 07:27:56 INFO - ##### 07:27:56 INFO - ##### Running create-virtualenv step. 07:27:56 INFO - ##### 07:27:56 INFO - Running pre-action listener: _resource_record_pre_action 07:27:56 INFO - Running main action method: create_virtualenv 07:27:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:27:56 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 07:27:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:27:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:56 INFO - Using real prefix '/usr' 07:27:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:27:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:59 INFO - Installing pip.................done. 07:27:59 INFO - Return code: 0 07:27:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:27:59 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')]} 07:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 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')]} 07:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:27:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:27:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:27:59 INFO - Using env: {'DISPLAY': ':0', 07:27:59 INFO - 'HOME': '/home/cltbld', 07:27:59 INFO - 'LANG': 'en_US.UTF-8', 07:27:59 INFO - 'LANGUAGE': 'en_US:en', 07:27:59 INFO - 'LOGNAME': 'cltbld', 07:27:59 INFO - 'MAIL': '/var/mail/cltbld', 07:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:59 INFO - 'MOZ_NO_REMOTE': '1', 07:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:59 INFO - 'NO_EM_RESTART': '1', 07:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:59 INFO - 'SHELL': '/bin/bash', 07:27:59 INFO - 'SHLVL': '1', 07:27:59 INFO - 'TERM': 'linux', 07:27:59 INFO - 'TMOUT': '86400', 07:27:59 INFO - 'USER': 'cltbld', 07:27:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:59 INFO - '_': '/tools/buildbot/bin/python'} 07:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:59 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 07:27:59 INFO - Cleaning up... 07:27:59 INFO - Return code: 0 07:27:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:27:59 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')]} 07:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 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')]} 07:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:27:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:27:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:27:59 INFO - Using env: {'DISPLAY': ':0', 07:27:59 INFO - 'HOME': '/home/cltbld', 07:27:59 INFO - 'LANG': 'en_US.UTF-8', 07:27:59 INFO - 'LANGUAGE': 'en_US:en', 07:27:59 INFO - 'LOGNAME': 'cltbld', 07:27:59 INFO - 'MAIL': '/var/mail/cltbld', 07:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:59 INFO - 'MOZ_NO_REMOTE': '1', 07:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:59 INFO - 'NO_EM_RESTART': '1', 07:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:27:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:27:59 INFO - 'SHELL': '/bin/bash', 07:27:59 INFO - 'SHLVL': '1', 07:27:59 INFO - 'TERM': 'linux', 07:27:59 INFO - 'TMOUT': '86400', 07:27:59 INFO - 'USER': 'cltbld', 07:27:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:59 INFO - '_': '/tools/buildbot/bin/python'} 07:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:59 INFO - Downloading/unpacking psutil>=0.7.1 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:27:59 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 07:28:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:01 INFO - Installing collected packages: psutil 07:28:01 INFO - Running setup.py install for psutil 07:28:01 INFO - building 'psutil._psutil_linux' extension 07:28:01 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 07:28:01 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 07:28:02 INFO - building 'psutil._psutil_posix' extension 07:28:02 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 07:28:02 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 07:28:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:02 INFO - Successfully installed psutil 07:28:02 INFO - Cleaning up... 07:28:02 INFO - Return code: 0 07:28:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:28:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:28:02 INFO - Using env: {'DISPLAY': ':0', 07:28:02 INFO - 'HOME': '/home/cltbld', 07:28:02 INFO - 'LANG': 'en_US.UTF-8', 07:28:02 INFO - 'LANGUAGE': 'en_US:en', 07:28:02 INFO - 'LOGNAME': 'cltbld', 07:28:02 INFO - 'MAIL': '/var/mail/cltbld', 07:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:02 INFO - 'MOZ_NO_REMOTE': '1', 07:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:02 INFO - 'NO_EM_RESTART': '1', 07:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:02 INFO - 'SHELL': '/bin/bash', 07:28:02 INFO - 'SHLVL': '1', 07:28:02 INFO - 'TERM': 'linux', 07:28:02 INFO - 'TMOUT': '86400', 07:28:02 INFO - 'USER': 'cltbld', 07:28:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:02 INFO - '_': '/tools/buildbot/bin/python'} 07:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:04 INFO - Installing collected packages: mozsystemmonitor 07:28:04 INFO - Running setup.py install for mozsystemmonitor 07:28:04 INFO - Successfully installed mozsystemmonitor 07:28:04 INFO - Cleaning up... 07:28:04 INFO - Return code: 0 07:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:28: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')]} 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:28:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:28:04 INFO - Using env: {'DISPLAY': ':0', 07:28:04 INFO - 'HOME': '/home/cltbld', 07:28:04 INFO - 'LANG': 'en_US.UTF-8', 07:28:04 INFO - 'LANGUAGE': 'en_US:en', 07:28:04 INFO - 'LOGNAME': 'cltbld', 07:28:04 INFO - 'MAIL': '/var/mail/cltbld', 07:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:04 INFO - 'MOZ_NO_REMOTE': '1', 07:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:04 INFO - 'NO_EM_RESTART': '1', 07:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:04 INFO - 'SHELL': '/bin/bash', 07:28:04 INFO - 'SHLVL': '1', 07:28:04 INFO - 'TERM': 'linux', 07:28:04 INFO - 'TMOUT': '86400', 07:28:04 INFO - 'USER': 'cltbld', 07:28:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:04 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:28:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:07 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 07:28:07 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 07:28:07 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 07:28:07 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 07:28:07 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 07:28:07 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 07:28:07 INFO - Downloading docopt-0.6.1.tar.gz 07:28:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:07 INFO - Running setup.py install for blobuploader 07:28:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:28:07 INFO - Running setup.py install for requests 07:28:07 INFO - Running setup.py install for docopt 07:28:07 INFO - Successfully installed blobuploader requests docopt 07:28:07 INFO - Cleaning up... 07:28:07 INFO - Return code: 0 07:28:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:28:07 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')]} 07:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 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')]} 07:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 07:28:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 07:28:07 INFO - Using env: {'DISPLAY': ':0', 07:28:07 INFO - 'HOME': '/home/cltbld', 07:28:07 INFO - 'LANG': 'en_US.UTF-8', 07:28:07 INFO - 'LANGUAGE': 'en_US:en', 07:28:07 INFO - 'LOGNAME': 'cltbld', 07:28:07 INFO - 'MAIL': '/var/mail/cltbld', 07:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:07 INFO - 'MOZ_NO_REMOTE': '1', 07:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:07 INFO - 'NO_EM_RESTART': '1', 07:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:07 INFO - 'SHELL': '/bin/bash', 07:28:07 INFO - 'SHLVL': '1', 07:28:07 INFO - 'TERM': 'linux', 07:28:07 INFO - 'TMOUT': '86400', 07:28:07 INFO - 'USER': 'cltbld', 07:28:07 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:07 INFO - '_': '/tools/buildbot/bin/python'} 07:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:28:08 INFO - Running setup.py (path:/tmp/pip-DaQmaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:28:08 INFO - Running setup.py (path:/tmp/pip-hwN8Wf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:28:08 INFO - Running setup.py (path:/tmp/pip-8jYQPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:28:08 INFO - Running setup.py (path:/tmp/pip-cEeqK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:28:08 INFO - Running setup.py (path:/tmp/pip-2EPSe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:28:08 INFO - Running setup.py (path:/tmp/pip-Tn87e8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:28:08 INFO - Running setup.py (path:/tmp/pip-KVPZlZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:28:08 INFO - Running setup.py (path:/tmp/pip-mhFQk3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:28:08 INFO - Running setup.py (path:/tmp/pip-Tyh5rh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:28:08 INFO - Running setup.py (path:/tmp/pip-GgWoHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:28:08 INFO - Running setup.py (path:/tmp/pip-5JZJLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:28:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:28:08 INFO - Running setup.py (path:/tmp/pip-nBE0Zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:28:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:28:09 INFO - Running setup.py (path:/tmp/pip-VcD3QP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:28:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:28:09 INFO - Running setup.py (path:/tmp/pip-n8ndh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:28:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:28:09 INFO - Running setup.py (path:/tmp/pip-VY_kJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:28:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:28:09 INFO - Running setup.py (path:/tmp/pip-GkDyFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:28:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:28:09 INFO - Running setup.py (path:/tmp/pip-cUEOSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:28:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:09 INFO - Running setup.py install for manifestparser 07:28:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:28:09 INFO - Running setup.py install for mozcrash 07:28:09 INFO - Running setup.py install for mozdebug 07:28:09 INFO - Running setup.py install for mozdevice 07:28:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:28:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:28:09 INFO - Running setup.py install for mozfile 07:28:09 INFO - Running setup.py install for mozhttpd 07:28:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:28:09 INFO - Running setup.py install for mozinfo 07:28:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for mozInstall 07:28:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for mozleak 07:28:10 INFO - Running setup.py install for mozlog 07:28:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for moznetwork 07:28:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for mozprocess 07:28:10 INFO - Running setup.py install for mozprofile 07:28:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for mozrunner 07:28:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:28:10 INFO - Running setup.py install for mozscreenshot 07:28:10 INFO - Running setup.py install for moztest 07:28:11 INFO - Running setup.py install for mozversion 07:28:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:28:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:11 INFO - Cleaning up... 07:28:11 INFO - Return code: 0 07:28:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:28:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:28:11 INFO - Using env: {'DISPLAY': ':0', 07:28:11 INFO - 'HOME': '/home/cltbld', 07:28:11 INFO - 'LANG': 'en_US.UTF-8', 07:28:11 INFO - 'LANGUAGE': 'en_US:en', 07:28:11 INFO - 'LOGNAME': 'cltbld', 07:28:11 INFO - 'MAIL': '/var/mail/cltbld', 07:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:11 INFO - 'MOZ_NO_REMOTE': '1', 07:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:11 INFO - 'NO_EM_RESTART': '1', 07:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:11 INFO - 'SHELL': '/bin/bash', 07:28:11 INFO - 'SHLVL': '1', 07:28:11 INFO - 'TERM': 'linux', 07:28:11 INFO - 'TMOUT': '86400', 07:28:11 INFO - 'USER': 'cltbld', 07:28:11 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:11 INFO - '_': '/tools/buildbot/bin/python'} 07:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:28:11 INFO - Running setup.py (path:/tmp/pip-VA4rf6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:28:11 INFO - Running setup.py (path:/tmp/pip-Z4xfwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:28:11 INFO - Running setup.py (path:/tmp/pip-CPEbES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:28:11 INFO - Running setup.py (path:/tmp/pip-v7jGKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:28:11 INFO - Running setup.py (path:/tmp/pip-ARh8mA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:28:11 INFO - Running setup.py (path:/tmp/pip-AKcj5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:28:11 INFO - Running setup.py (path:/tmp/pip-7cMTPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:28:11 INFO - Running setup.py (path:/tmp/pip-dp2P3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:28:11 INFO - Running setup.py (path:/tmp/pip-KGc1Qe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:28:11 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)) 07:28:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:28:11 INFO - Running setup.py (path:/tmp/pip-jDpnCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:28:12 INFO - Running setup.py (path:/tmp/pip-X1PKGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:28:12 INFO - Running setup.py (path:/tmp/pip-I7_U_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:28:12 INFO - Running setup.py (path:/tmp/pip-qI5fuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:28:12 INFO - Running setup.py (path:/tmp/pip-pFSYIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:28:12 INFO - Running setup.py (path:/tmp/pip-DJ7fmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:28:12 INFO - Running setup.py (path:/tmp/pip-hKRHLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:28:12 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)) 07:28:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:28:12 INFO - Running setup.py (path:/tmp/pip-M54Cwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:28:12 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)) 07:28:12 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:12 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)) 07:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:12 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:14 INFO - Downloading blessings-1.6.tar.gz 07:28:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:14 INFO - Installing collected packages: blessings 07:28:14 INFO - Running setup.py install for blessings 07:28:14 INFO - Successfully installed blessings 07:28:14 INFO - Cleaning up... 07:28:14 INFO - Return code: 0 07:28:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:28:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:28:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:28:14 INFO - Reading from file tmpfile_stdout 07:28:14 INFO - Current package versions: 07:28:14 INFO - argparse == 1.2.1 07:28:14 INFO - blessings == 1.6 07:28:14 INFO - blobuploader == 1.2.4 07:28:14 INFO - docopt == 0.6.1 07:28:14 INFO - manifestparser == 1.1 07:28:14 INFO - mozInstall == 1.12 07:28:14 INFO - mozcrash == 0.17 07:28:14 INFO - mozdebug == 0.1 07:28:14 INFO - mozdevice == 0.48 07:28:14 INFO - mozfile == 1.2 07:28:14 INFO - mozhttpd == 0.7 07:28:14 INFO - mozinfo == 0.9 07:28:14 INFO - mozleak == 0.1 07:28:14 INFO - mozlog == 3.1 07:28:14 INFO - moznetwork == 0.27 07:28:14 INFO - mozprocess == 0.22 07:28:14 INFO - mozprofile == 0.28 07:28:14 INFO - mozrunner == 6.11 07:28:14 INFO - mozscreenshot == 0.1 07:28:14 INFO - mozsystemmonitor == 0.0 07:28:14 INFO - moztest == 0.7 07:28:14 INFO - mozversion == 1.4 07:28:14 INFO - psutil == 3.1.1 07:28:14 INFO - requests == 1.2.3 07:28:14 INFO - wsgiref == 0.1.2 07:28:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:28: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')]} 07:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 07:28:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 07:28:14 INFO - Using env: {'DISPLAY': ':0', 07:28:14 INFO - 'HOME': '/home/cltbld', 07:28:14 INFO - 'LANG': 'en_US.UTF-8', 07:28:14 INFO - 'LANGUAGE': 'en_US:en', 07:28:14 INFO - 'LOGNAME': 'cltbld', 07:28:14 INFO - 'MAIL': '/var/mail/cltbld', 07:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:14 INFO - 'MOZ_NO_REMOTE': '1', 07:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:14 INFO - 'NO_EM_RESTART': '1', 07:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:14 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:14 INFO - 'SHELL': '/bin/bash', 07:28:14 INFO - 'SHLVL': '1', 07:28:14 INFO - 'TERM': 'linux', 07:28:14 INFO - 'TMOUT': '86400', 07:28:14 INFO - 'USER': 'cltbld', 07:28:14 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:14 INFO - '_': '/tools/buildbot/bin/python'} 07:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 07:28:15 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 2)) 07:28:15 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 3)) 07:28:15 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 4)) 07:28:15 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 5)) 07:28:15 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 6)) 07:28:15 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 7)) 07:28:15 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 8)) 07:28:15 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 9)) 07:28:15 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:28:15 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 4)) 07:28:15 INFO - Cleaning up... 07:28:15 INFO - Return code: 0 07:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:28:15 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')]} 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:15 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')]} 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test-pgo/build 07:28:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 jsonschema 07:28:15 INFO - Using env: {'DISPLAY': ':0', 07:28:15 INFO - 'HOME': '/home/cltbld', 07:28:15 INFO - 'LANG': 'en_US.UTF-8', 07:28:15 INFO - 'LANGUAGE': 'en_US:en', 07:28:15 INFO - 'LOGNAME': 'cltbld', 07:28:15 INFO - 'MAIL': '/var/mail/cltbld', 07:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:15 INFO - 'MOZ_NO_REMOTE': '1', 07:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:15 INFO - 'NO_EM_RESTART': '1', 07:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:15 INFO - 'SHELL': '/bin/bash', 07:28:15 INFO - 'SHLVL': '1', 07:28:15 INFO - 'TERM': 'linux', 07:28:15 INFO - 'TMOUT': '86400', 07:28:15 INFO - 'USER': 'cltbld', 07:28:15 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:15 INFO - '_': '/tools/buildbot/bin/python'} 07:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:15 INFO - Downloading/unpacking jsonschema 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:17 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:17 INFO - warning: no files found matching '*.txt' 07:28:17 INFO - no previously-included directories found matching 'build' 07:28:17 INFO - no previously-included directories found matching 'dist' 07:28:17 INFO - no previously-included directories found matching '.git*' 07:28:17 INFO - Installing collected packages: jsonschema, functools32 07:28:17 INFO - Running setup.py install for functools32 07:28:17 INFO - warning: no files found matching '*.txt' 07:28:17 INFO - no previously-included directories found matching 'build' 07:28:17 INFO - no previously-included directories found matching 'dist' 07:28:17 INFO - no previously-included directories found matching '.git*' 07:28:17 INFO - Successfully installed jsonschema functools32 07:28:17 INFO - Cleaning up... 07:28:17 INFO - Return code: 0 07:28:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:28: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')]} 07:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad5d8d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf996d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', '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 07:28:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 07:28:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 07:28:17 INFO - Using env: {'DISPLAY': ':0', 07:28:17 INFO - 'HOME': '/home/cltbld', 07:28:17 INFO - 'LANG': 'en_US.UTF-8', 07:28:17 INFO - 'LANGUAGE': 'en_US:en', 07:28:17 INFO - 'LOGNAME': 'cltbld', 07:28:17 INFO - 'MAIL': '/var/mail/cltbld', 07:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:17 INFO - 'MOZ_NO_REMOTE': '1', 07:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:17 INFO - 'NO_EM_RESTART': '1', 07:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:17 INFO - 'SHELL': '/bin/bash', 07:28:17 INFO - 'SHLVL': '1', 07:28:17 INFO - 'TERM': 'linux', 07:28:17 INFO - 'TMOUT': '86400', 07:28:17 INFO - 'USER': 'cltbld', 07:28:17 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:17 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:17 INFO - Downloading/unpacking flake8 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:17 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 07:28:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:19 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 07:28:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:20 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 07:28:20 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 07:28:20 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 07:28:20 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 07:28:20 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 07:28:20 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 07:28:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:20 INFO - no previously-included directories found matching 'docs/_build' 07:28:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:20 INFO - Running setup.py install for pep8 07:28:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:20 INFO - no previously-included directories found matching 'docs/_build' 07:28:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:28:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:20 INFO - Cleaning up... 07:28:20 INFO - Return code: 0 07:28:20 INFO - Running post-action listener: _resource_record_post_action 07:28:20 INFO - Running post-action listener: _start_resource_monitoring 07:28:20 INFO - Starting resource monitoring. 07:28:20 INFO - ##### 07:28:20 INFO - ##### Running install step. 07:28:20 INFO - ##### 07:28:20 INFO - Running pre-action listener: _resource_record_pre_action 07:28:20 INFO - Running main action method: install 07:28:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:28:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:28:20 INFO - Reading from file tmpfile_stdout 07:28:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:28:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:28:20 INFO - Reading from file tmpfile_stdout 07:28:20 INFO - Output received: 07:28:20 INFO - Usage: mozinstall [options] installer 07:28:20 INFO - Options: 07:28:20 INFO - -h, --help show this help message and exit 07:28:20 INFO - -d DEST, --destination=DEST 07:28:20 INFO - Directory to install application into. [default: 07:28:20 INFO - "/builds/slave/test-pgo"] 07:28:20 INFO - --app=APP Application being installed. [default: firefox] 07:28:20 INFO - mkdir: /builds/slave/test-pgo/build/application 07:28:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:28:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:28:37 INFO - Reading from file tmpfile_stdout 07:28:37 INFO - Output received: 07:28:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:28:37 INFO - Running post-action listener: _resource_record_post_action 07:28:37 INFO - ##### 07:28:37 INFO - ##### Running run-tests step. 07:28:37 INFO - ##### 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: run_tests 07:28:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:28:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:28:37 INFO - Python 2.7.3 07:28:37 INFO - Return code: 0 07:28:37 INFO - grabbing minidump binary from tooltool 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 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 0x1028920>, '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 0x1029820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:28:37 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 07:28:37 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 07:28:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:37 INFO - Return code: 0 07:28:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:28:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:28:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:28:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:28:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:28:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:28:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:28:38 INFO - Return code: 0 07:28:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 07:28:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:28:38 INFO - Using env: {'DISPLAY': ':0', 07:28:38 INFO - 'HOME': '/home/cltbld', 07:28:38 INFO - 'LANG': 'en_US.UTF-8', 07:28:38 INFO - 'LANGUAGE': 'en_US:en', 07:28:38 INFO - 'LOGNAME': 'cltbld', 07:28:38 INFO - 'MAIL': '/var/mail/cltbld', 07:28:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:28:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:38 INFO - 'MOZ_NO_REMOTE': '1', 07:28:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:38 INFO - 'NO_EM_RESTART': '1', 07:28:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:28:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:28:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:28:38 INFO - 'SHELL': '/bin/bash', 07:28:38 INFO - 'SHLVL': '1', 07:28:38 INFO - 'TERM': 'linux', 07:28:38 INFO - 'TMOUT': '86400', 07:28:38 INFO - 'USER': 'cltbld', 07:28:38 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299', 07:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:38 INFO - '_': '/tools/buildbot/bin/python'} 07:28:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:28:38 INFO - mozversion application_buildid: 20160311043041 07:28:38 INFO - mozversion application_changeset: f30fc906416f25adf1fff45ff2466ddaaaec23c4 07:28:38 INFO - mozversion application_display_name: Nightly 07:28:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:38 INFO - mozversion application_name: Firefox 07:28:38 INFO - mozversion application_remotingname: firefox 07:28:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:38 INFO - mozversion application_vendor: Mozilla 07:28:38 INFO - mozversion application_version: 48.0a1 07:28:38 INFO - mozversion platform_buildid: 20160311043041 07:28:38 INFO - mozversion platform_changeset: f30fc906416f25adf1fff45ff2466ddaaaec23c4 07:28:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:38 INFO - mozversion platform_version: 48.0a1 07:28:38 INFO - using testdate: 1457710118 07:28:38 INFO - actual date: 1457710118 07:28:38 INFO - starting webserver on 'localhost:47038' 07:28:38 INFO - SUITE-START | Running 2 tests 07:28:38 INFO - TEST-START | dromaeo_css 07:28:38 INFO - operating with platform_type : linux_ 07:28:38 INFO - Initialising browser for dromaeo_css test... 07:28:38 INFO - TEST-INFO | started process 14534 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmputF18R/profile http://localhost:47038/getInfo.html) 07:28:41 INFO - PROCESS | 14534 | 07:28:41 INFO - PROCESS | 14534 | (process:14617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:42 INFO - PROCESS | 14534 | __metrics Screen width/height:1600/1200 07:28:42 INFO - PROCESS | 14534 | colorDepth:24 07:28:42 INFO - PROCESS | 14534 | Browser inner width/height: 1024/697 07:28:42 INFO - PROCESS | 14534 | __metrics 07:28:43 ERROR - PROCESS | 14534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 07:28:44 INFO - TEST-INFO | 14534: exit 0 07:28:44 INFO - Browser initialized. 07:28:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:44 INFO - TEST-INFO | started process 14669 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmputF18R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:46 INFO - PROCESS | 14669 | 07:28:46 INFO - PROCESS | 14669 | (process:14729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:56 INFO - PROCESS | 14669 | RSS: Main: 165998592 07:28:56 INFO - PROCESS | 14669 | 07:29:45 INFO - PROCESS | 14669 | 1457710185795 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] 07:31:54 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47038/tests/dromaeo/cssquery-ext.html) 07:31:55 INFO - PROCESS | 14669 | RSS: Main: 170438656 07:31:55 INFO - PROCESS | 14669 | 07:34:57 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-ext.html (next: http://localhost:47038/tests/dromaeo/cssquery-jquery.html) 07:34:58 INFO - PROCESS | 14669 | RSS: Main: 167927808 07:34:58 INFO - PROCESS | 14669 | 07:37:59 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47038/tests/dromaeo/cssquery-mootools.html) 07:38:00 INFO - PROCESS | 14669 | RSS: Main: 169340928 07:38:00 INFO - PROCESS | 14669 | 07:41:02 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47038/tests/dromaeo/cssquery-prototype.html) 07:41:02 INFO - PROCESS | 14669 | RSS: Main: 167841792 07:41:02 INFO - PROCESS | 14669 | 07:44:05 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47038/tests/dromaeo/cssquery-yui.html) 07:44:05 INFO - PROCESS | 14669 | RSS: Main: 167677952 07:44:05 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | Cycle 1(1): loaded http://localhost:47038/tests/dromaeo/cssquery-yui.html (next: http://localhost:47038/tests/dromaeo/cssquery-dojo.html) 07:47:08 INFO - PROCESS | 14669 | RSS: Main: 171356160 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | __start_tp_report 07:47:08 INFO - PROCESS | 14669 | _x_x_mozilla_page_load 07:47:08 INFO - PROCESS | 14669 | _x_x_mozilla_page_load_details 07:47:08 INFO - PROCESS | 14669 | |i|pagename|runs| 07:47:08 INFO - PROCESS | 14669 | |0;dojo.html;3141.874325026999;3154.463741164002;3170.8573114209858;3221.2752130770577;3225.7258133058704;5209.062368773624;5219.660722053064;5222.268882356469;5232.084385232583;5248.816291429801;5162.845114646567;5207.6354655174155;5247.422783493813;5249.580033597313;5344.198370244465;4756.524347565241;4782.378290822188;4837.758112094399;4895.21676531755;4968.950310496885;4831.299461578069;4836.395450568679;4858.975705121487;4878.682885612441;4896.975515122419;4760.928586071194;4800.879978000526;4853.660243782937;4883.804647814083;4920.8031678732805;4751.3585665935;4757.191277482836;4771.642126840501;4781.3784208053075;4799.18413869643;4748.857534273943;4754.857354279377;4766.428028636586;4767.880802979918;4788.0663270662235;5164.8192313268855;5170.379554453452;5188.247704082887;5200;5200.6879587224885;5650.0959846424785;5658.349289831681;5658.8302350929125;5690.374058853523;5696.344920334173;5652.491275785158;5712.11462223356;5720.77116915327;5752.223449834302;5781.595288329819;5293.735313234323;5300.920486192672;5304.151335786256;5318.414974352818;5329.626926115174;5733.655980641175;5737.655740655574;5747.511461525817;5747.971260143756;5751.252337196138;5432.565394768409;5523.8066667666435;5550.944490555043;5551.639143455663;5608.635438696471;5587.106063029977;5631.1271752878365;5637.49262566371;5651.886962260814;5661.264035675335;5604.887902241932;5609.15862620602;5620.690862002547;5622.606417550814;5673.177389278614;5541.556675465953;5587.832365029056;5620.466055724782;5632.324121105494;5633.408492108351;4354.9564504355185;4366.366876802846;4368.148211098869;4379.364992076131;4410.735355878657;3907.628775266345;3913.3542965410957;3918.6081391861157;3921.843126274974;3961.6830653547645;5285.233641122016;5306.071437498423;5338.54622357104;5347;5375.435579264121;5612.607117501817;5634.60557760961;5639.605227634026;5642.6614403135945;5646.0683987141665;5284.471552844761;5296.682199068068;5306.495882891119;5321.2018197269945;5364.785408583691;4784.258439941815;4798.616110711135;4811.206150985118;4827.710337379768;4867.34290870735;5804.390538993429;5847.561432892465;5856.209411729447;5884.264466941632;5892.469677729025;5587.441255874543;5613.578981576316;5623.915641265303;5637.3235211774845;5648.09630459141;5803.7678492861505;5814.215080964185;5836.795712150054;5861.882762344814;5902.350741418526;5595.216669666169;5607.691576963306;5607.915881261866;5613.971930140487;5616.747246374005;5558.833235002957;5619.185218143428;5690.743916523849;5700.771969121189;5713.05734553794;5383.40782513931;5511.448855114457;5522.475364840334;5588.692621905834;5606.467385598362;5423.078076727044;5460.890782184255;5461.290032295776;5466.207399926909;5468.179773034077;5380.112281473513;5385.569154467712;5410.323709536308;5414.377346605033;5482.23248745168;5512.035393806148;5541.030319694118;5558.777648893999;5560;5591.049521581423;5381.085215513451;5387.191921211849;5388.326459192601;5427.511523962862;5434.918476222781 07:47:08 INFO - PROCESS | 14669 | |1;ext.html;501.1005245584176;526.2842534153552;558.8323502949115;580.9477147056765;592.0527156549522;37449.81275093624;37478;37505.43741843875;37595.43606845896;37647.4352884707;40787.38818917711;41288.58711412885;41342;41431.58568414315;41592.37611435823;8528.06191318956;8689.087645797195;8749.693760718375;8751.299896008304;8766.56167191641;8569.95715021424;8656.350773691998;8658.48049117055;8674.956625216897;8701.738947831574;8756.60595273211;8820;8880.200781929625;8917.33120015998;8920.197182253596;8731.039585645605;8880.712296716973;8895.73312800617;8911.420757650765;8919.68781092665;8827.823443531157;8949.55252237392;8951.597178127;8973.192412682825;8981.6856410026;40127;40450.39324410136;40514.39228411576;40539.74332695083;40740.79629601863;2607.2178346495975;2924.5613158026467;3010.7591392688532;3081.014075495842;3408.386490431721;28993.56509652357;29205.41589168226;29292;29487.55768663472;30197.698023019708;3588.67701906827;3607.4047782115917;3610.9097272568133;3647.8723244686307;3758.229562939618;278006;280045;281240;282142;283297;42400.57599424028;61423.69288153531;61537.69231153905;62215.688921555105;62355.68822155951;41088;41128.38307425391;41206.38190427146;41237;41263;14984.250787460584;15312;15344.616384590252;15366.615834604001;15392.230388480531;11947.701307467383;12017.218880772896;12056.276623402624;12063.758724825455;12081.275123492618;13997.580072597635;14084.647883802782;14478.782818257734;14479.565613031626;14658;5702.258706368146;5707.3545707753765;5732.828015159552;5834.737436815353;5841;947.8341290274312;960.1934375124929;976.4678250353575;978.0757184460758;988.2242439684813;27806.3048423791;28718.71281287202;28846.7115328844;29037.41925161485;29172.85413572961;1026.779242462874;1047.1570385839473;1049.4228174504144;1053.599632139782;1153.3887039868882;14574.562763117123;15024.42243564432;15144.697106058038;15202.239888005555;15308.540743777481;311170;312597;314443;316656;316866;51800;52063.73968130135;52145.47854521482;52301.7384913073;52314;1306.4447609765812;1323.1796286302554;1351.7228968061524;1363.6863521390135;1363.7545241856362;27321.86339068292;28597.85701071481;28601.856990714914;28864.42271154523;29019.27451813637;45508.31737523874;45743.08513829771;46075;46127.76936115298;46163;291201;292935;293166;293401;294157;31866.84066579745;32238.516422254153;32909.83545082259;33003;33177;43224;44443.77778111089;44556;44619.107617846814;44709;35286.647133528335;37173;37305.13082736795;37731.62268377281;37733.24533509369;36485.27029459449;37041.81479092587;37060.81469592635;37210.813945930095;37479.43780843235;35394.64605353914;36453.27093458169;36469.27061458809;36603.81698091599;36766.44850327301;30703.539446907867;32955.505667415484;33260;33445;33588.66411335953;25170.496590068462;25668.358291042874;25887.411258873963;25921.611175832753;25945.87027064928 07:47:08 INFO - PROCESS | 14669 | |2;jquery.html;343.72330274129325;352.63854549087165;354.11647938393713;361.60946178127625;365.56315203332014;16956.83043169568;16974.151292435374;17936.28254869805;17991.3703020394;17993.64012719748;16164.191790410461;16628.33486660535;16730.079845608485;17189.312427502886;17228.310867565313;4858.757062146896;5279.604029697778;5465.043617366965;5490.862728431801;5495.477929596682;5394.6493477924005;5413.810516631918;5439.347278326587;5478.342598888119;5481.945180548203;5277.973610131963;5418.9458105419035;5441.863953401177;5445.774700692333;5465.398806131322;5371.301730774994;5389.973050134763;5404.297441332602;5405.486478784529;5421.268128802601;4765.809367625291;4816.614670826326;4826.806927722887;4837.467878533358;4847.781849816767;12280.877191228152;12720.681982950407;20288.087036083263;20604.381868543816;20892.686609700868;1851.1114664960894;1870.9345172918881;1874.953126171843;1927.1616846671743;2021.989890050555;9586.281028922858;9629.90370096297;10118.54466549007;10683.679489615324;12549.309787961658;1656.1967445788782;1657.693326734558;1699.158916336409;1717.7423386492;1722.4402069327393;61499;61746.38253617496;61916;62115.06827397593;63940.680296598686;9879.555420006118;10045.899541004497;10265.230107741949;10288.845667314996;10463.790724185626;13302.401391937387;13457.394417251247;13538.120022198525;13565.186088834702;13588.524401646093;7652.69389224436;7658.578778167254;7706.884396734054;7707.152213256537;7772.145064042951;7423;7482.326590606763;7569.962150189213;7754.224577542201;7780.8832867507035;4269.658427325807;4297;4375.431193944767;4389.078293558388;4410.007748256617;1785.5089850291015;1844.8616353773252;1851.7500137481536;1919.865609407356;1923.3268356075262;892.4734406700078;897.6364572348209;964.1226483899618;1041.094248004226;1054.9050585447346;16614.6677066458;16714.83285167157;16876.15619219034;17058.658826823394;17191.31234750621;887.3522328700085;901.8376692195336;913.3013244867682;952.1478276942237;958.0371726415048;9529.904700952902;9698;9818.214542836557;9832.705018849447;9855.408675479493;400796;401301;410811;410994;411257;64420.677896610214;69552.65223673951;73625;74670;74876.25123748802;985.1133979418437;1017.9643712470028;1047.3349423116376;1054.7574057966558;1057.5928267616869;14434.711305774035;15333.846661533242;15384.84615153834;15534.84465155334;15791.526254212393;30897;31160.532592010684;33159.50260746139;33339.83330083334;34468.48297275493;40035.799821000706;41661.25048745627;42133.367999480644;42673.359899602154;43535;7620.399716059468;7624.428167887319;7863.52818830872;7889.171636978034;7902.4863383879865;9839.606415743576;11931.701707457036;11940.343281119622;11998.340091295062;12042.759144816879;5207.661502002357;6064.636121832704;10027.197824173903;10270.794584108426;10302.433366164933;10198.949005254926;10221.897781022391;10223.335483193569;10265.435401052715;10404.947975260075;10275.332103413255;10340.689779306633;10465.424401657981;10615.203859710708;10744.570217191225;7305.634718263959;7394.186639469762;7396.186419493743;7467.477276590804;7945;9057.501837399006;9901.504924753877;9951.701448956543;10063;10099.899001009895 07:47:08 INFO - PROCESS | 14669 | |3;mootools.html;1527.4806565767637;1535.0143969978392;1728;1809.1587411853486;1836.9540761480969;7010;7538.095428548568;7793.688252469901;7977.5612341321275;7990.96004519978;7444.585528749534;7492.7377541786045;7561.357284630799;7568.243175682429;7576.31813136819;2153.6015837070113;2154.353693891834;2175.434387059368;2176.804087632113;2177.7060096886876;2167.8482506224573;2173.9239126630573;2212.1372664660794;2225.376894469551;2235.8211343092594;2164.0586344939925;2169.5769324981634;2186.6501359782437;2200.119952019197;2206.0293470872843;2122.5754849030177;2130.19052759951;2132.1364847236896;2133.3173384516963;2144.3674116135776;2174.5433458973635;2201.625723626987;2204.4819467425305;2206.2278202629113;2207.2716003718733;7647.120581133129;7677.11713152989;7688.115866675348;7706.730264440774;7713.5757533335645;4746.691465054761;4893.608511319121;4901.1177987962155;4905.411350637911;4921.138800709861;2938.691437399085;3039.4984827503436;3051.5880356151856;3069.600951876264;3077.1537827097504;884.7699598104475;900.6667533012761;904.6110172625769;913.6939125393002;947.7346343023964;10690.839637405445;10708.892911070867;10751.064808334497;10822.35065896041;10831.67504974852;4070.430139780433;4284.721493102938;4397.736135831797;4397.802098905557;4433.556644335606;8396.790080248044;8473.1526847316;8488.448250863674;8492.40553161285;8501.61742721579;4715.24556071027;4728.05438912219;4733.905321893543;4743.169945259566;4757.762111894392;3985;4253.234417804825;4330.047389574289;4393.758343291086;4410.42664453619;3284.0640417480904;3316.4859446785786;3317.5853018372704;3342.231286804;3366.9494957575657;971.4656938683696;1008.5612758450097;1008.6016023670609;1008.6873069348526;1017.5777052523268;910.9498977556166;923.7921467669721;1309.4369421148806;1327.595083499542;1352.1008529327887;7452.292032256927;7492.400607951351;7499.475036747375;7501.324880760649;7511.399088072941;445.3364486914539;455.54218010898836;463.9489656137822;465.0791432962753;465.353159108839;5757.251557297524;5786.1610066540115;5801.767929282866;5817.7091145442555;5873.177755114288;9311.953440232755;9700.611975521042;9728.027197280215;9792.55933482995;9856.31005829585;9570.234381249484;9624.51877406127;9681.225501959827;9682.273829462818;9717.805643887225;7166.426685865118;7556.622168891643;7580.279873412017;7592.506487078433;7611;7278.745243916437;7287.817804554928;7329.230430804689;7356.190819009797;7368.705251789868;8378.287845532954;8583.914160858561;8617.784555386166;8622.913770862462;8651.653933842575;8749.431286966326;8971.730848074569;8980.012198658273;8996.05541418168;9061.275097992277;5721.685307308138;5896.970515147397;6178.752849885954;6303.495720342454;6318.052292156213;7504;7525.510841795266;7558.58427786477;7569.280918312751;7584.203658615987;6254.155688982111;6320.5891617044745;6405.167328247298;6609.900851487328;6630.569013014138;6500.317466666121;6558.376954189344;6586.736530538725;6657.966710166418;6663.333666633298;6850.760223392157;7147.820609599358;7158.248383919822;7162.319579639926;7166.140063192451;6158.661273629993;6411.903821442589;6424.13274207976;6607.669616519251;6670;6469.126667899774;6547.738090476328;6555.180602424697;6575.605463672195;6580.80257592273 07:47:08 INFO - PROCESS | 14669 | |4;prototype.html;346.4197469239025;348.43727380280836;348.96684814942574;350.06183428411845;354.60815798542626;6256.7497300108;6278.811635650932;6305.558610897239;6322.968385158068;6362.204724409449;6217;6232.626042437446;6233.3143354231;6236.594621349609;6240.282367527724;4616.884577885546;4772.498887616803;4782.378290822206;4790.712557246559;4800.3279540864305;4755.453122890877;4782;4792.808287668489;4798.256270278112;4799.952000480003;4728;4741.431028276595;4741.786619602109;4752.192127338343;4762.071396077767;4703.341532185496;4728.078024785168;4739.976300118512;4749.050189962004;4753.572178503917;4115.8971025724295;4127.277726397899;4129.938050929239;4136.772477513736;4143.606357396043;5925.2889653241455;5933.554983376264;5953.255843019622;5968.283805943272;5990.161377407167;5311.282976798121;5518.19986102013;5523.944760552424;5526.364468086182;5529.281193444866;6603.570767900071;6606;6626.939689649681;6627.469802415843;6628.105205797252;4489.59593636571;4520.457545094577;4524.479684836253;4528.615067719248;4529.705569137996;6864.759733409307;6921.446284297244;6935.514513984023;6971;6971.825704357381;4677;4678.719276843332;4680.180968330528;4686.437627484655;4697.718136911796;4528.230200865861;4647.930281045787;4661.254199328091;4679.344891715163;4707.599854012379;5452.318460192476;5479.369872464717;5493.23094766733;5497.367802702661;5511.448855114457;6605.768798092044;6633.369829866155;6640.568363056386;6663.4669226461765;6670.466362690973;1645.7202275613174;1674.2298542670264;1675.4219794170992;1675.4554769699896;1675.656490419461;1079.6383211624193;1093.5953697132113;1100.5652767156928;1107.9667609971714;1125.943702814856;6327.462165715873;6353.30113687494;6355.745770169141;6376.489880809524;6381.1385462962835;6785.830354241085;6790.219124800612;6831.248562658104;6843.213030501556;6862.965685171542;6083.726232319556;6251.12484252205;6298.212723409574;6417.871642567123;6418.390252925965;3708;3737;3762.830672619739;3768.8680896168503;3769.754965927206;7211.67547460355;7222.313880181375;7289.2346303638415;7292.781216563511;7315.30504602062;7090.645467726593;7094.893576596355;7106.2183159852375;7121.216666166718;7135.143782746104;7017.4386049116965;7245.637718114073;7273.636318184175;7280.344768970924;7288.854222915512;6870.725170993104;6891.896621550781;6893.827654308682;6894.551854129666;6899.6205208714;6816.386525212754;6817.522773405814;6826.556273842184;6837.6239306836615;6854.828629284308;7261.564306141649;7272;7275.1997280298065;7276.163241227327;7279.599622020628;4502.684812063124;4629.86110416688;4636.327732478839;4665.766711664471;4667.9766601166775;6831.351021652935;6845.178578570603;6845.247022827584;6875.5874647521305;6884.896726549206;6602.537822352389;6637.966810165918;6639.103720997604;6651.201855777144;6655.035019922181;6596.934030659632;6643;6652.900206497004;6653.900191497229;6656.567323123982;6409.038644203407;6544.312847150981;6545.443637290884;6551.836204094936;6564.113844630913;6666.766663166766;6667.166604174478;6685.799426017227;6695.832604184934;6705.329467053256;6490;6499.1876015498065;6505.186851643544;6521.282658907421;6526.184226971629 07:47:08 INFO - PROCESS | 14669 | |5;yui.html;576.0696475192565;594.0791772752235;626.9090981807637;697.8081027717378;747.9790086531884;12961.351932403377;12962.611121666341;13104.41030153643;13197.472101115956;13273.933630331847;11451.312921224733;11633.069354451645;11642.126840486955;11705.648830535098;11783.528658853636;832.5129799067538;848.8259906719107;849.2399302624148;849.6771226933756;850.9531975741331;684.9246582875879;833.3916241143938;849.7918010087507;851.0638297872322;852.6546748566809;881.568031664483;887.077439462961;892.7366426904078;893.3791015244408;894.4946105450432;879.5821984557348;884.2307192742292;885.2077390735288;886.3352485635774;886.4814083761007;645.6771614192903;649.217692680319;651.1437459740426;651.3128649275013;652.139176287301;12523.43644535989;12543.372831358396;12597.307148106851;12603.117781755282;12622.747545049047;12825.67935801603;12962.935185324013;13171.078024538287;13254.072214944958;13268.800967985488;9481.47851868147;9516;9586.401589269439;9685.225181985425;9757.804843903154;3281.1633033576522;3332.96667033329;3353.262282297915;3375.257443362481;3380.5605271314816;45927;45986.31020534695;46086.30870536945;46089.30866037046;46235;9496.916844604966;9564.378315409476;9651.420914744996;9736.561854716554;9833.36083154607;18564.44306670802;18633.7204941926;18718.625627487647;18754.906225469058;18801.717974230396;6859.2454829968665;6998.545094568837;7063.293670632998;7114.857702845914;7124.8575028499135;3986.9202615948097;4061.878143655695;4098.897527561835;4116;4117.300058989979;2906.084583356236;2907.941841163165;2917.5769513420437;2923.4007028559095;2929.1066224801216;550.3313474128953;570.5920267009109;571.3771988532519;580.115324130704;584.9005669036189;549.6262541471758;559.7509108446784;561.2731512691075;570.7174948400568;571.44855214718;7883.36933045355;7975.202479751978;8082.151374105634;8186.754397368089;8199.918000820035;547.9835604931858;608.4949491921783;633.9033472093305;641.8940874755613;645.6384424722171;3641.781493110369;3654.1778099927838;3693.1505753676806;3777.036855601804;3806.2958352704286;53660;58777.11834322489;58822.70588647029;59384;59469.70265148646;48639.756801215764;48759.26861097087;49022.75488622534;49482.50517494851;49744.75127624339;45056.3241551377;45253.54746452559;45915.77042114835;45999.31001034987;46004;7928.246816552418;8134.674613015413;8154.266116049584;8206.097329293654;8326.875096873431;32976.505352419255;33266.83366583152;33330.33339333248;34175.65824341824;34433.31133377369;38592;40553.59446405498;41900.580994189666;42126.578734212264;42144.78927605342;9738.902610973799;10088.243381746544;10097.253861990404;10161.136303413998;10292.536835842555;10874.94562527214;10905.781884362426;10935.890641093487;11112.555497779998;11186.161037922026;10528.578856845641;10598.629047983284;10801.189910756882;10881.78236435251;10985.285956412808;10911.181661375269;11044.779104418027;11146.386948717898;11328.773424531628;11573.421328933688;10811.513481893177;10965.61620343284;10969.945150274198;11213.271137376045;11263.380514071478;9168.083191680778;9363.157315841607;9426.434413935185;9588.089131532493;9631.855522167032;7915.722949696733;8142.715004974797;8195.590220488832;8588.26999705032;8733.30133589324 07:47:08 INFO - PROCESS | 14669 | __end_tp_report 07:47:08 INFO - PROCESS | 14669 | __start_cc_report 07:47:08 INFO - PROCESS | 14669 | _x_x_mozilla_cycle_collect,341 07:47:08 INFO - PROCESS | 14669 | __end_cc_report 07:47:08 INFO - PROCESS | 14669 | __startTimestamp1457711228416__endTimestamp 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | ------- Summary: start ------- 07:47:08 INFO - PROCESS | 14669 | Number of tests: 6 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#0] dojo.html Cycles:165 Average:5245.64 Median:5414.38 stddev:570.68 (10.5%) stddev-sans-first:548.05 07:47:08 INFO - PROCESS | 14669 | Values: 3141.9 3154.5 3170.9 3221.3 3225.7 5209.1 5219.7 5222.3 5232.1 5248.8 5162.8 5207.6 5247.4 5249.6 5344.2 4756.5 4782.4 4837.8 4895.2 4969.0 4831.3 4836.4 4859.0 4878.7 4897.0 4760.9 4800.9 4853.7 4883.8 4920.8 4751.4 4757.2 4771.6 4781.4 4799.2 4748.9 4754.9 4766.4 4767.9 4788.1 5164.8 5170.4 5188.2 5200.0 5200.7 5650.1 5658.3 5658.8 5690.4 5696.3 5652.5 5712.1 5720.8 5752.2 5781.6 5293.7 5300.9 5304.2 5318.4 5329.6 5733.7 5737.7 5747.5 5748.0 5751.3 5432.6 5523.8 5550.9 5551.6 5608.6 5587.1 5631.1 5637.5 5651.9 5661.3 5604.9 5609.2 5620.7 5622.6 5673.2 5541.6 5587.8 5620.5 5632.3 5633.4 4355.0 4366.4 4368.1 4379.4 4410.7 3907.6 3913.4 3918.6 3921.8 3961.7 5285.2 5306.1 5338.5 5347.0 5375.4 5612.6 5634.6 5639.6 5642.7 5646.1 5284.5 5296.7 5306.5 5321.2 5364.8 4784.3 4798.6 4811.2 4827.7 4867.3 5804.4 5847.6 5856.2 5884.3 5892.5 5587.4 5613.6 5623.9 5637.3 5648.1 5803.8 5814.2 5836.8 5861.9 5902.4 5595.2 5607.7 5607.9 5614.0 5616.7 5558.8 5619.2 5690.7 5700.8 5713.1 5383.4 5511.4 5522.5 5588.7 5606.5 5423.1 5460.9 5461.3 5466.2 5468.2 5380.1 5385.6 5410.3 5414.4 5482.2 5512.0 5541.0 5558.8 5560.0 5591.0 5381.1 5387.2 5388.3 5427.5 5434.9 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#1] ext.html Cycles:180 Average:45954.76 Median:36904.13 stddev:77469.13 (209.9%) stddev-sans-first:77611.28 07:47:08 INFO - PROCESS | 14669 | Values: 501.1 526.3 558.8 580.9 592.1 37449.8 37478.0 37505.4 37595.4 37647.4 40787.4 41288.6 41342.0 41431.6 41592.4 8528.1 8689.1 8749.7 8751.3 8766.6 8570.0 8656.4 8658.5 8675.0 8701.7 8756.6 8820.0 8880.2 8917.3 8920.2 8731.0 8880.7 8895.7 8911.4 8919.7 8827.8 8949.6 8951.6 8973.2 8981.7 40127.0 40450.4 40514.4 40539.7 40740.8 2607.2 2924.6 3010.8 3081.0 3408.4 28993.6 29205.4 29292.0 29487.6 30197.7 3588.7 3607.4 3610.9 3647.9 3758.2 278006.0 280045.0 281240.0 282142.0 283297.0 42400.6 61423.7 61537.7 62215.7 62355.7 41088.0 41128.4 41206.4 41237.0 41263.0 14984.3 15312.0 15344.6 15366.6 15392.2 11947.7 12017.2 12056.3 12063.8 12081.3 13997.6 14084.6 14478.8 14479.6 14658.0 5702.3 5707.4 5732.8 5834.7 5841.0 947.8 960.2 976.5 978.1 988.2 27806.3 28718.7 28846.7 29037.4 29172.9 1026.8 1047.2 1049.4 1053.6 1153.4 14574.6 15024.4 15144.7 15202.2 15308.5 311170.0 312597.0 314443.0 316656.0 316866.0 51800.0 52063.7 52145.5 52301.7 52314.0 1306.4 1323.2 1351.7 1363.7 1363.8 27321.9 28597.9 28601.9 28864.4 29019.3 45508.3 45743.1 46075.0 46127.8 46163.0 291201.0 292935.0 293166.0 293401.0 294157.0 31866.8 32238.5 32909.8 33003.0 33177.0 43224.0 44443.8 44556.0 44619.1 44709.0 35286.6 37173.0 37305.1 37731.6 37733.2 36485.3 37041.8 37060.8 37210.8 37479.4 35394.6 36453.3 36469.3 36603.8 36766.4 30703.5 32955.5 33260.0 33445.0 33588.7 25170.5 25668.4 25887.4 25921.6 25945.9 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#2] jquery.html Cycles:180 Average:23992.06 Median:410902.50 stddev:66778.91 (16.3%) stddev-sans-first:66942.64 07:47:08 INFO - PROCESS | 14669 | Values: 343.7 352.6 354.1 361.6 365.6 16956.8 16974.2 17936.3 17991.4 17993.6 16164.2 16628.3 16730.1 17189.3 17228.3 4858.8 5279.6 5465.0 5490.9 5495.5 5394.6 5413.8 5439.3 5478.3 5481.9 5278.0 5418.9 5441.9 5445.8 5465.4 5371.3 5390.0 5404.3 5405.5 5421.3 4765.8 4816.6 4826.8 4837.5 4847.8 12280.9 12720.7 20288.1 20604.4 20892.7 1851.1 1870.9 1875.0 1927.2 2022.0 9586.3 9629.9 10118.5 10683.7 12549.3 1656.2 1657.7 1699.2 1717.7 1722.4 61499.0 61746.4 61916.0 62115.1 63940.7 9879.6 10045.9 10265.2 10288.8 10463.8 13302.4 13457.4 13538.1 13565.2 13588.5 7652.7 7658.6 7706.9 7707.2 7772.1 7423.0 7482.3 7570.0 7754.2 7780.9 4269.7 4297.0 4375.4 4389.1 4410.0 1785.5 1844.9 1851.8 1919.9 1923.3 892.5 897.6 964.1 1041.1 1054.9 16614.7 16714.8 16876.2 17058.7 17191.3 887.4 901.8 913.3 952.1 958.0 9529.9 9698.0 9818.2 9832.7 9855.4 400796.0 401301.0 410811.0 410994.0 411257.0 64420.7 69552.7 73625.0 74670.0 74876.3 985.1 1018.0 1047.3 1054.8 1057.6 14434.7 15333.8 15384.8 15534.8 15791.5 30897.0 31160.5 33159.5 33339.8 34468.5 40035.8 41661.3 42133.4 42673.4 43535.0 7620.4 7624.4 7863.5 7889.2 7902.5 9839.6 11931.7 11940.3 11998.3 12042.8 5207.7 6064.6 10027.2 10270.8 10302.4 10198.9 10221.9 10223.3 10265.4 10404.9 10275.3 10340.7 10465.4 10615.2 10744.6 7305.6 7394.2 7396.2 7467.5 7945.0 9057.5 9901.5 9951.7 10063.0 10099.9 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#3] mootools.html Cycles:180 Average:5403.56 Median:6408.54 stddev:2888.82 (45.1%) stddev-sans-first:2882.24 07:47:08 INFO - PROCESS | 14669 | Values: 1527.5 1535.0 1728.0 1809.2 1837.0 7010.0 7538.1 7793.7 7977.6 7991.0 7444.6 7492.7 7561.4 7568.2 7576.3 2153.6 2154.4 2175.4 2176.8 2177.7 2167.8 2173.9 2212.1 2225.4 2235.8 2164.1 2169.6 2186.7 2200.1 2206.0 2122.6 2130.2 2132.1 2133.3 2144.4 2174.5 2201.6 2204.5 2206.2 2207.3 7647.1 7677.1 7688.1 7706.7 7713.6 4746.7 4893.6 4901.1 4905.4 4921.1 2938.7 3039.5 3051.6 3069.6 3077.2 884.8 900.7 904.6 913.7 947.7 10690.8 10708.9 10751.1 10822.4 10831.7 4070.4 4284.7 4397.7 4397.8 4433.6 8396.8 8473.2 8488.4 8492.4 8501.6 4715.2 4728.1 4733.9 4743.2 4757.8 3985.0 4253.2 4330.0 4393.8 4410.4 3284.1 3316.5 3317.6 3342.2 3366.9 971.5 1008.6 1008.6 1008.7 1017.6 910.9 923.8 1309.4 1327.6 1352.1 7452.3 7492.4 7499.5 7501.3 7511.4 445.3 455.5 463.9 465.1 465.4 5757.3 5786.2 5801.8 5817.7 5873.2 9312.0 9700.6 9728.0 9792.6 9856.3 9570.2 9624.5 9681.2 9682.3 9717.8 7166.4 7556.6 7580.3 7592.5 7611.0 7278.7 7287.8 7329.2 7356.2 7368.7 8378.3 8583.9 8617.8 8622.9 8651.7 8749.4 8971.7 8980.0 8996.1 9061.3 5721.7 5897.0 6178.8 6303.5 6318.1 7504.0 7525.5 7558.6 7569.3 7584.2 6254.2 6320.6 6405.2 6609.9 6630.6 6500.3 6558.4 6586.7 6658.0 6663.3 6850.8 7147.8 7158.2 7162.3 7166.1 6158.7 6411.9 6424.1 6607.7 6670.0 6469.1 6547.7 6555.2 6575.6 6580.8 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#4] prototype.html Cycles:180 Average:5557.12 Median:6314.26 stddev:1698.87 (26.9%) stddev-sans-first:1658.01 07:47:08 INFO - PROCESS | 14669 | Values: 346.4 348.4 349.0 350.1 354.6 6256.7 6278.8 6305.6 6323.0 6362.2 6217.0 6232.6 6233.3 6236.6 6240.3 4616.9 4772.5 4782.4 4790.7 4800.3 4755.5 4782.0 4792.8 4798.3 4800.0 4728.0 4741.4 4741.8 4752.2 4762.1 4703.3 4728.1 4740.0 4749.1 4753.6 4115.9 4127.3 4129.9 4136.8 4143.6 5925.3 5933.6 5953.3 5968.3 5990.2 5311.3 5518.2 5523.9 5526.4 5529.3 6603.6 6606.0 6626.9 6627.5 6628.1 4489.6 4520.5 4524.5 4528.6 4529.7 6864.8 6921.4 6935.5 6971.0 6971.8 4677.0 4678.7 4680.2 4686.4 4697.7 4528.2 4647.9 4661.3 4679.3 4707.6 5452.3 5479.4 5493.2 5497.4 5511.4 6605.8 6633.4 6640.6 6663.5 6670.5 1645.7 1674.2 1675.4 1675.5 1675.7 1079.6 1093.6 1100.6 1108.0 1125.9 6327.5 6353.3 6355.7 6376.5 6381.1 6785.8 6790.2 6831.2 6843.2 6863.0 6083.7 6251.1 6298.2 6417.9 6418.4 3708.0 3737.0 3762.8 3768.9 3769.8 7211.7 7222.3 7289.2 7292.8 7315.3 7090.6 7094.9 7106.2 7121.2 7135.1 7017.4 7245.6 7273.6 7280.3 7288.9 6870.7 6891.9 6893.8 6894.6 6899.6 6816.4 6817.5 6826.6 6837.6 6854.8 7261.6 7272.0 7275.2 7276.2 7279.6 4502.7 4629.9 4636.3 4665.8 4668.0 6831.4 6845.2 6845.2 6875.6 6884.9 6602.5 6638.0 6639.1 6651.2 6655.0 6596.9 6643.0 6652.9 6653.9 6656.6 6409.0 6544.3 6545.4 6551.8 6564.1 6666.8 6667.2 6685.8 6695.8 6705.3 6490.0 6499.2 6505.2 6521.3 6526.2 07:47:08 INFO - PROCESS | 14669 | 07:47:08 INFO - PROCESS | 14669 | [#5] yui.html Cycles:180 Average:13265.39 Median:48891.01 stddev:15524.43 (31.8%) stddev-sans-first:15538.74 07:47:08 INFO - PROCESS | 14669 | Values: 576.1 594.1 626.9 697.8 748.0 12961.4 12962.6 13104.4 13197.5 13273.9 11451.3 11633.1 11642.1 11705.6 11783.5 832.5 848.8 849.2 849.7 851.0 684.9 833.4 849.8 851.1 852.7 881.6 887.1 892.7 893.4 894.5 879.6 884.2 885.2 886.3 886.5 645.7 649.2 651.1 651.3 652.1 12523.4 12543.4 12597.3 12603.1 12622.7 12825.7 12962.9 13171.1 13254.1 13268.8 9481.5 9516.0 9586.4 9685.2 9757.8 3281.2 3333.0 3353.3 3375.3 3380.6 45927.0 45986.3 46086.3 46089.3 46235.0 9496.9 9564.4 9651.4 9736.6 9833.4 18564.4 18633.7 18718.6 18754.9 18801.7 6859.2 6998.5 7063.3 7114.9 7124.9 3986.9 4061.9 4098.9 4116.0 4117.3 2906.1 2907.9 2917.6 2923.4 2929.1 550.3 570.6 571.4 580.1 584.9 549.6 559.8 561.3 570.7 571.4 7883.4 7975.2 8082.2 8186.8 8199.9 548.0 608.5 633.9 641.9 645.6 3641.8 3654.2 3693.2 3777.0 3806.3 53660.0 58777.1 58822.7 59384.0 59469.7 48639.8 48759.3 49022.8 49482.5 49744.8 45056.3 45253.5 45915.8 45999.3 46004.0 7928.2 8134.7 8154.3 8206.1 8326.9 32976.5 33266.8 33330.3 34175.7 34433.3 38592.0 40553.6 41900.6 42126.6 42144.8 9738.9 10088.2 10097.3 10161.1 10292.5 10874.9 10905.8 10935.9 11112.6 11186.2 10528.6 10598.6 10801.2 10881.8 10985.3 10911.2 11044.8 11146.4 11328.8 11573.4 10811.5 10965.6 10969.9 11213.3 11263.4 9168.1 9363.2 9426.4 9588.1 9631.9 7915.7 8142.7 8195.6 8588.3 8733.3 07:47:08 INFO - PROCESS | 14669 | -------- Summary: end -------- 07:47:08 INFO - PROCESS | 14669 | 07:47:09 INFO - TEST-INFO | 14669: exit 0 07:47:09 INFO - TEST-OK | dromaeo_css | took 1110878ms 07:47:09 INFO - TEST-START | kraken 07:47:09 INFO - operating with platform_type : linux_ 07:47:09 INFO - Initialising browser for kraken test... 07:47:09 INFO - TEST-INFO | started process 14904 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLaMzMZ/profile http://localhost:47038/getInfo.html) 07:47:12 INFO - PROCESS | 14904 | 07:47:12 INFO - PROCESS | 14904 | (process:14973): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:13 INFO - PROCESS | 14904 | __metrics Screen width/height:1600/1200 07:47:13 INFO - PROCESS | 14904 | colorDepth:24 07:47:13 INFO - PROCESS | 14904 | Browser inner width/height: 1024/697 07:47:13 INFO - PROCESS | 14904 | __metrics 07:47:13 ERROR - PROCESS | 14904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 07:47:14 INFO - TEST-INFO | 14904: exit 0 07:47:14 INFO - Browser initialized. 07:47:14 INFO - Running cycle 1/1 for kraken test... 07:47:14 INFO - TEST-INFO | started process 15025 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLaMzMZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:16 INFO - PROCESS | 15025 | 07:47:16 INFO - PROCESS | 15025 | (process:15088): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:26 INFO - PROCESS | 15025 | RSS: Main: 165707776 07:47:26 INFO - PROCESS | 15025 | 07:47:29 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47038/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:29 INFO - PROCESS | 15025 | RSS: Main: 170192896 07:47:29 INFO - PROCESS | 15025 | 07:47:32 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47038/tests/kraken/driver.html?testName=audio-dft) 07:47:33 INFO - PROCESS | 15025 | RSS: Main: 173355008 07:47:33 INFO - PROCESS | 15025 | 07:47:36 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47038/tests/kraken/driver.html?testName=audio-fft) 07:47:36 INFO - PROCESS | 15025 | RSS: Main: 165494784 07:47:36 INFO - PROCESS | 15025 | 07:47:38 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47038/tests/kraken/driver.html?testName=audio-oscillator) 07:47:39 INFO - PROCESS | 15025 | RSS: Main: 166903808 07:47:39 INFO - PROCESS | 15025 | 07:47:41 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:42 INFO - PROCESS | 15025 | RSS: Main: 166420480 07:47:42 INFO - PROCESS | 15025 | 07:47:45 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47038/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:45 INFO - PROCESS | 15025 | RSS: Main: 168783872 07:47:45 INFO - PROCESS | 15025 | 07:47:49 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47038/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:49 INFO - PROCESS | 15025 | RSS: Main: 169123840 07:47:49 INFO - PROCESS | 15025 | 07:47:52 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47038/tests/kraken/driver.html?testName=json-parse-financial) 07:47:53 INFO - PROCESS | 15025 | RSS: Main: 169472000 07:47:53 INFO - PROCESS | 15025 | 07:47:54 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:55 INFO - PROCESS | 15025 | RSS: Main: 169701376 07:47:55 INFO - PROCESS | 15025 | 07:47:57 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:57 INFO - PROCESS | 15025 | RSS: Main: 169398272 07:47:57 INFO - PROCESS | 15025 | 07:47:59 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:00 INFO - PROCESS | 15025 | RSS: Main: 169844736 07:48:00 INFO - PROCESS | 15025 | 07:48:02 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:03 INFO - PROCESS | 15025 | RSS: Main: 169435136 07:48:03 INFO - PROCESS | 15025 | 07:48:06 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:06 INFO - PROCESS | 15025 | RSS: Main: 171831296 07:48:06 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:47038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47038/tests/kraken/driver.html?testName=ai-astar) 07:48:08 INFO - PROCESS | 15025 | RSS: Main: 171950080 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | __start_tp_report 07:48:08 INFO - PROCESS | 15025 | _x_x_mozilla_page_load 07:48:08 INFO - PROCESS | 15025 | _x_x_mozilla_page_load_details 07:48:08 INFO - PROCESS | 15025 | |i|pagename|runs| 07:48:08 INFO - PROCESS | 15025 | |0;ai-astar;113;106;114;113;111;124;110;110;112;113 07:48:08 INFO - PROCESS | 15025 | |1;audio-beat-detection;158;129;154;171;131;156;157;137;167;137 07:48:08 INFO - PROCESS | 15025 | |2;audio-dft;166;164;163;162;162;161;163;174;166;163 07:48:08 INFO - PROCESS | 15025 | |3;audio-fft;74;75;76;77;78;75;76;77;130;77 07:48:08 INFO - PROCESS | 15025 | |4;audio-oscillator;94;94;145;94;94;94;155;92;94;150 07:48:08 INFO - PROCESS | 15025 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;118 07:48:08 INFO - PROCESS | 15025 | |6;imaging-darkroom;145;145;146;149;146;146;147;146;146;147 07:48:08 INFO - PROCESS | 15025 | |7;imaging-desaturate;97;97;96;98;97;96;96;96;96;95 07:48:08 INFO - PROCESS | 15025 | |8;json-parse-financial;58;57;58;60;58;58;57;59;57;56 07:48:08 INFO - PROCESS | 15025 | |9;json-stringify-tinderbox;70;70;70;69;70;70;70;70;70;69 07:48:08 INFO - PROCESS | 15025 | |10;stanford-crypto-aes;80;82;84;83;83;82;82;81;83;82 07:48:08 INFO - PROCESS | 15025 | |11;stanford-crypto-ccm;122;124;118;137;119;115;121;116;117;121 07:48:08 INFO - PROCESS | 15025 | |12;stanford-crypto-pbkdf2;135;144;143;142;146;133;150;144;146;133 07:48:08 INFO - PROCESS | 15025 | |13;stanford-crypto-sha256-iterative;69;70;70;67;70;67;68;68;69;69 07:48:08 INFO - PROCESS | 15025 | __end_tp_report 07:48:08 INFO - PROCESS | 15025 | __start_cc_report 07:48:08 INFO - PROCESS | 15025 | _x_x_mozilla_cycle_collect,825 07:48:08 INFO - PROCESS | 15025 | __end_cc_report 07:48:08 INFO - PROCESS | 15025 | __startTimestamp1457711288685__endTimestamp 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | ------- Summary: start ------- 07:48:08 INFO - PROCESS | 15025 | Number of tests: 14 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:4.62 (4.1%) stddev-sans-first:4.90 07:48:08 INFO - PROCESS | 15025 | Values: 113.0 106.0 114.0 113.0 111.0 124.0 110.0 110.0 112.0 113.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:156.50 stddev:15.03 (9.6%) stddev-sans-first:15.64 07:48:08 INFO - PROCESS | 15025 | Values: 158.0 129.0 154.0 171.0 131.0 156.0 157.0 137.0 167.0 137.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.75 (2.3%) stddev-sans-first:3.93 07:48:08 INFO - PROCESS | 15025 | Values: 166.0 164.0 163.0 162.0 162.0 161.0 163.0 174.0 166.0 163.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:17.08 (22.3%) stddev-sans-first:17.90 07:48:08 INFO - PROCESS | 15025 | Values: 74.0 75.0 76.0 77.0 78.0 75.0 76.0 77.0 130.0 77.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:27.30 (29.0%) stddev-sans-first:28.28 07:48:08 INFO - PROCESS | 15025 | Values: 94.0 94.0 145.0 94.0 94.0 94.0 155.0 92.0 94.0 150.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:48:08 INFO - PROCESS | 15025 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 07:48:08 INFO - PROCESS | 15025 | Values: 145.0 145.0 146.0 149.0 146.0 146.0 147.0 146.0 146.0 147.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 07:48:08 INFO - PROCESS | 15025 | Values: 97.0 97.0 96.0 98.0 97.0 96.0 96.0 96.0 96.0 95.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.14 (2.0%) stddev-sans-first:1.20 07:48:08 INFO - PROCESS | 15025 | Values: 58.0 57.0 58.0 60.0 58.0 58.0 57.0 59.0 57.0 56.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:48:08 INFO - PROCESS | 15025 | Values: 70.0 70.0 70.0 69.0 70.0 70.0 70.0 70.0 70.0 69.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.14 (1.4%) stddev-sans-first:0.88 07:48:08 INFO - PROCESS | 15025 | Values: 80.0 82.0 84.0 83.0 83.0 82.0 82.0 81.0 83.0 82.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.00 stddev:6.29 (5.2%) stddev-sans-first:6.66 07:48:08 INFO - PROCESS | 15025 | Values: 122.0 124.0 118.0 137.0 119.0 115.0 121.0 116.0 117.0 121.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:144.00 stddev:5.91 (4.1%) stddev-sans-first:5.77 07:48:08 INFO - PROCESS | 15025 | Values: 135.0 144.0 143.0 142.0 146.0 133.0 150.0 144.0 146.0 133.0 07:48:08 INFO - PROCESS | 15025 | 07:48:08 INFO - PROCESS | 15025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 07:48:08 INFO - PROCESS | 15025 | Values: 69.0 70.0 70.0 67.0 70.0 67.0 68.0 68.0 69.0 69.0 07:48:08 INFO - PROCESS | 15025 | -------- Summary: end -------- 07:48:08 INFO - PROCESS | 15025 | 07:48:09 INFO - TEST-INFO | 15025: exit 0 07:48:09 INFO - TEST-OK | kraken | took 60432ms 07:48:09 INFO - SUITE-END | took 1171s 07:48:09 INFO - Completed test suite (00:19:31) 07:48:09 INFO - javascript benchmark 07:48:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3141.874325026999, 3154.463741164002, 3170.8573114209858, 3221.2752130770577, 3225.7258133058704, 5209.062368773624, 5219.660722053064, 5222.268882356469, 5232.084385232583, 5248.816291429801, 5162.845114646567, 5207.6354655174155, 5247.422783493813, 5249.580033597313, 5344.198370244465, 4756.524347565241, 4782.378290822188, 4837.758112094399, 4895.21676531755, 4968.950310496885, 4831.299461578069, 4836.395450568679, 4858.975705121487, 4878.682885612441, 4896.975515122419, 4760.928586071194, 4800.879978000526, 4853.660243782937, 4883.804647814083, 4920.8031678732805, 4751.3585665935, 4757.191277482836, 4771.642126840501, 4781.3784208053075, 4799.18413869643, 4748.857534273943, 4754.857354279377, 4766.428028636586, 4767.880802979918, 4788.0663270662235, 5164.8192313268855, 5170.379554453452, 5188.247704082887, 5200.0, 5200.6879587224885, 5650.0959846424785, 5658.349289831681, 5658.8302350929125, 5690.374058853523, 5696.344920334173, 5652.491275785158, 5712.11462223356, 5720.77116915327, 5752.223449834302, 5781.595288329819, 5293.735313234323, 5300.920486192672, 5304.151335786256, 5318.414974352818, 5329.626926115174, 5733.655980641175, 5737.655740655574, 5747.511461525817, 5747.971260143756, 5751.252337196138, 5432.565394768409, 5523.8066667666435, 5550.944490555043, 5551.639143455663, 5608.635438696471, 5587.106063029977, 5631.1271752878365, 5637.49262566371, 5651.886962260814, 5661.264035675335, 5604.887902241932, 5609.15862620602, 5620.690862002547, 5622.606417550814, 5673.177389278614, 5541.556675465953, 5587.832365029056, 5620.466055724782, 5632.324121105494, 5633.408492108351, 4354.9564504355185, 4366.366876802846, 4368.148211098869, 4379.364992076131, 4410.735355878657, 3907.628775266345, 3913.3542965410957, 3918.6081391861157, 3921.843126274974, 3961.6830653547645, 5285.233641122016, 5306.071437498423, 5338.54622357104, 5347.0, 5375.435579264121, 5612.607117501817, 5634.60557760961, 5639.605227634026, 5642.6614403135945, 5646.0683987141665, 5284.471552844761, 5296.682199068068, 5306.495882891119, 5321.2018197269945, 5364.785408583691, 4784.258439941815, 4798.616110711135, 4811.206150985118, 4827.710337379768, 4867.34290870735, 5804.390538993429, 5847.561432892465, 5856.209411729447, 5884.264466941632, 5892.469677729025, 5587.441255874543, 5613.578981576316, 5623.915641265303, 5637.3235211774845, 5648.09630459141, 5803.7678492861505, 5814.215080964185, 5836.795712150054, 5861.882762344814, 5902.350741418526, 5595.216669666169, 5607.691576963306, 5607.915881261866, 5613.971930140487, 5616.747246374005, 5558.833235002957, 5619.185218143428, 5690.743916523849, 5700.771969121189, 5713.05734553794, 5383.40782513931, 5511.448855114457, 5522.475364840334, 5588.692621905834, 5606.467385598362, 5423.078076727044, 5460.890782184255, 5461.290032295776, 5466.207399926909, 5468.179773034077, 5380.112281473513, 5385.569154467712, 5410.323709536308, 5414.377346605033, 5482.23248745168, 5512.035393806148, 5541.030319694118, 5558.777648893999, 5560.0, 5591.049521581423, 5381.085215513451, 5387.191921211849, 5388.326459192601, 5427.511523962862, 5434.918476222781], "unit": "score", "name": "dojo.html", "value": 5209.338490239955}, {"lowerIsBetter": false, "replicates": [501.1005245584176, 526.2842534153552, 558.8323502949115, 580.9477147056765, 592.0527156549522, 37449.81275093624, 37478.0, 37505.43741843875, 37595.43606845896, 37647.4352884707, 40787.38818917711, 41288.58711412885, 41342.0, 41431.58568414315, 41592.37611435823, 8528.06191318956, 8689.087645797195, 8749.693760718375, 8751.299896008304, 8766.56167191641, 8569.95715021424, 8656.350773691998, 8658.48049117055, 8674.956625216897, 8701.738947831574, 8756.60595273211, 8820.0, 8880.200781929625, 8917.33120015998, 8920.197182253596, 8731.039585645605, 8880.712296716973, 8895.73312800617, 8911.420757650765, 8919.68781092665, 8827.823443531157, 8949.55252237392, 8951.597178127, 8973.192412682825, 8981.6856410026, 40127.0, 40450.39324410136, 40514.39228411576, 40539.74332695083, 40740.79629601863, 2607.2178346495975, 2924.5613158026467, 3010.7591392688532, 3081.014075495842, 3408.386490431721, 28993.56509652357, 29205.41589168226, 29292.0, 29487.55768663472, 30197.698023019708, 3588.67701906827, 3607.4047782115917, 3610.9097272568133, 3647.8723244686307, 3758.229562939618, 278006.0, 280045.0, 281240.0, 282142.0, 283297.0, 42400.57599424028, 61423.69288153531, 61537.69231153905, 62215.688921555105, 62355.68822155951, 41088.0, 41128.38307425391, 41206.38190427146, 41237.0, 41263.0, 14984.250787460584, 15312.0, 15344.616384590252, 15366.615834604001, 15392.230388480531, 11947.701307467383, 12017.218880772896, 12056.276623402624, 12063.758724825455, 12081.275123492618, 13997.580072597635, 14084.647883802782, 14478.782818257734, 14479.565613031626, 14658.0, 5702.258706368146, 5707.3545707753765, 5732.828015159552, 5834.737436815353, 5841.0, 947.8341290274312, 960.1934375124929, 976.4678250353575, 978.0757184460758, 988.2242439684813, 27806.3048423791, 28718.71281287202, 28846.7115328844, 29037.41925161485, 29172.85413572961, 1026.779242462874, 1047.1570385839473, 1049.4228174504144, 1053.599632139782, 1153.3887039868882, 14574.562763117123, 15024.42243564432, 15144.697106058038, 15202.239888005555, 15308.540743777481, 311170.0, 312597.0, 314443.0, 316656.0, 316866.0, 51800.0, 52063.73968130135, 52145.47854521482, 52301.7384913073, 52314.0, 1306.4447609765812, 1323.1796286302554, 1351.7228968061524, 1363.6863521390135, 1363.7545241856362, 27321.86339068292, 28597.85701071481, 28601.856990714914, 28864.42271154523, 29019.27451813637, 45508.31737523874, 45743.08513829771, 46075.0, 46127.76936115298, 46163.0, 291201.0, 292935.0, 293166.0, 293401.0, 294157.0, 31866.84066579745, 32238.516422254153, 32909.83545082259, 33003.0, 33177.0, 43224.0, 44443.77778111089, 44556.0, 44619.107617846814, 44709.0, 35286.647133528335, 37173.0, 37305.13082736795, 37731.62268377281, 37733.24533509369, 36485.27029459449, 37041.81479092587, 37060.81469592635, 37210.813945930095, 37479.43780843235, 35394.64605353914, 36453.27093458169, 36469.27061458809, 36603.81698091599, 36766.44850327301, 30703.539446907867, 32955.505667415484, 33260.0, 33445.0, 33588.66411335953, 25170.496590068462, 25668.358291042874, 25887.411258873963, 25921.611175832753, 25945.87027064928], "unit": "score", "name": "ext.html", "value": 17943.83769703038}, {"lowerIsBetter": false, "replicates": [343.72330274129325, 352.63854549087165, 354.11647938393713, 361.60946178127625, 365.56315203332014, 16956.83043169568, 16974.151292435374, 17936.28254869805, 17991.3703020394, 17993.64012719748, 16164.191790410461, 16628.33486660535, 16730.079845608485, 17189.312427502886, 17228.310867565313, 4858.757062146896, 5279.604029697778, 5465.043617366965, 5490.862728431801, 5495.477929596682, 5394.6493477924005, 5413.810516631918, 5439.347278326587, 5478.342598888119, 5481.945180548203, 5277.973610131963, 5418.9458105419035, 5441.863953401177, 5445.774700692333, 5465.398806131322, 5371.301730774994, 5389.973050134763, 5404.297441332602, 5405.486478784529, 5421.268128802601, 4765.809367625291, 4816.614670826326, 4826.806927722887, 4837.467878533358, 4847.781849816767, 12280.877191228152, 12720.681982950407, 20288.087036083263, 20604.381868543816, 20892.686609700868, 1851.1114664960894, 1870.9345172918881, 1874.953126171843, 1927.1616846671743, 2021.989890050555, 9586.281028922858, 9629.90370096297, 10118.54466549007, 10683.679489615324, 12549.309787961658, 1656.1967445788782, 1657.693326734558, 1699.158916336409, 1717.7423386492, 1722.4402069327393, 61499.0, 61746.38253617496, 61916.0, 62115.06827397593, 63940.680296598686, 9879.555420006118, 10045.899541004497, 10265.230107741949, 10288.845667314996, 10463.790724185626, 13302.401391937387, 13457.394417251247, 13538.120022198525, 13565.186088834702, 13588.524401646093, 7652.69389224436, 7658.578778167254, 7706.884396734054, 7707.152213256537, 7772.145064042951, 7423.0, 7482.326590606763, 7569.962150189213, 7754.224577542201, 7780.8832867507035, 4269.658427325807, 4297.0, 4375.431193944767, 4389.078293558388, 4410.007748256617, 1785.5089850291015, 1844.8616353773252, 1851.7500137481536, 1919.865609407356, 1923.3268356075262, 892.4734406700078, 897.6364572348209, 964.1226483899618, 1041.094248004226, 1054.9050585447346, 16614.6677066458, 16714.83285167157, 16876.15619219034, 17058.658826823394, 17191.31234750621, 887.3522328700085, 901.8376692195336, 913.3013244867682, 952.1478276942237, 958.0371726415048, 9529.904700952902, 9698.0, 9818.214542836557, 9832.705018849447, 9855.408675479493, 400796.0, 401301.0, 410811.0, 410994.0, 411257.0, 64420.677896610214, 69552.65223673951, 73625.0, 74670.0, 74876.25123748802, 985.1133979418437, 1017.9643712470028, 1047.3349423116376, 1054.7574057966558, 1057.5928267616869, 14434.711305774035, 15333.846661533242, 15384.84615153834, 15534.84465155334, 15791.526254212393, 30897.0, 31160.532592010684, 33159.50260746139, 33339.83330083334, 34468.48297275493, 40035.799821000706, 41661.25048745627, 42133.367999480644, 42673.359899602154, 43535.0, 7620.399716059468, 7624.428167887319, 7863.52818830872, 7889.171636978034, 7902.4863383879865, 9839.606415743576, 11931.701707457036, 11940.343281119622, 11998.340091295062, 12042.759144816879, 5207.661502002357, 6064.636121832704, 10027.197824173903, 10270.794584108426, 10302.433366164933, 10198.949005254926, 10221.897781022391, 10223.335483193569, 10265.435401052715, 10404.947975260075, 10275.332103413255, 10340.689779306633, 10465.424401657981, 10615.203859710708, 10744.570217191225, 7305.634718263959, 7394.186639469762, 7396.186419493743, 7467.477276590804, 7945.0, 9057.501837399006, 9901.504924753877, 9951.701448956543, 10063.0, 10099.899001009895], "unit": "score", "name": "jquery.html", "value": 8125.403906809483}, {"lowerIsBetter": false, "replicates": [1527.4806565767637, 1535.0143969978392, 1728.0, 1809.1587411853486, 1836.9540761480969, 7010.0, 7538.095428548568, 7793.688252469901, 7977.5612341321275, 7990.96004519978, 7444.585528749534, 7492.7377541786045, 7561.357284630799, 7568.243175682429, 7576.31813136819, 2153.6015837070113, 2154.353693891834, 2175.434387059368, 2176.804087632113, 2177.7060096886876, 2167.8482506224573, 2173.9239126630573, 2212.1372664660794, 2225.376894469551, 2235.8211343092594, 2164.0586344939925, 2169.5769324981634, 2186.6501359782437, 2200.119952019197, 2206.0293470872843, 2122.5754849030177, 2130.19052759951, 2132.1364847236896, 2133.3173384516963, 2144.3674116135776, 2174.5433458973635, 2201.625723626987, 2204.4819467425305, 2206.2278202629113, 2207.2716003718733, 7647.120581133129, 7677.11713152989, 7688.115866675348, 7706.730264440774, 7713.5757533335645, 4746.691465054761, 4893.608511319121, 4901.1177987962155, 4905.411350637911, 4921.138800709861, 2938.691437399085, 3039.4984827503436, 3051.5880356151856, 3069.600951876264, 3077.1537827097504, 884.7699598104475, 900.6667533012761, 904.6110172625769, 913.6939125393002, 947.7346343023964, 10690.839637405445, 10708.892911070867, 10751.064808334497, 10822.35065896041, 10831.67504974852, 4070.430139780433, 4284.721493102938, 4397.736135831797, 4397.802098905557, 4433.556644335606, 8396.790080248044, 8473.1526847316, 8488.448250863674, 8492.40553161285, 8501.61742721579, 4715.24556071027, 4728.05438912219, 4733.905321893543, 4743.169945259566, 4757.762111894392, 3985.0, 4253.234417804825, 4330.047389574289, 4393.758343291086, 4410.42664453619, 3284.0640417480904, 3316.4859446785786, 3317.5853018372704, 3342.231286804, 3366.9494957575657, 971.4656938683696, 1008.5612758450097, 1008.6016023670609, 1008.6873069348526, 1017.5777052523268, 910.9498977556166, 923.7921467669721, 1309.4369421148806, 1327.595083499542, 1352.1008529327887, 7452.292032256927, 7492.400607951351, 7499.475036747375, 7501.324880760649, 7511.399088072941, 445.3364486914539, 455.54218010898836, 463.9489656137822, 465.0791432962753, 465.353159108839, 5757.251557297524, 5786.1610066540115, 5801.767929282866, 5817.7091145442555, 5873.177755114288, 9311.953440232755, 9700.611975521042, 9728.027197280215, 9792.55933482995, 9856.31005829585, 9570.234381249484, 9624.51877406127, 9681.225501959827, 9682.273829462818, 9717.805643887225, 7166.426685865118, 7556.622168891643, 7580.279873412017, 7592.506487078433, 7611.0, 7278.745243916437, 7287.817804554928, 7329.230430804689, 7356.190819009797, 7368.705251789868, 8378.287845532954, 8583.914160858561, 8617.784555386166, 8622.913770862462, 8651.653933842575, 8749.431286966326, 8971.730848074569, 8980.012198658273, 8996.05541418168, 9061.275097992277, 5721.685307308138, 5896.970515147397, 6178.752849885954, 6303.495720342454, 6318.052292156213, 7504.0, 7525.510841795266, 7558.58427786477, 7569.280918312751, 7584.203658615987, 6254.155688982111, 6320.5891617044745, 6405.167328247298, 6609.900851487328, 6630.569013014138, 6500.317466666121, 6558.376954189344, 6586.736530538725, 6657.966710166418, 6663.333666633298, 6850.760223392157, 7147.820609599358, 7158.248383919822, 7162.319579639926, 7166.140063192451, 6158.661273629993, 6411.903821442589, 6424.13274207976, 6607.669616519251, 6670.0, 6469.126667899774, 6547.738090476328, 6555.180602424697, 6575.605463672195, 6580.80257592273], "unit": "score", "name": "mootools.html", "value": 4311.881769376869}, {"lowerIsBetter": false, "replicates": [346.4197469239025, 348.43727380280836, 348.96684814942574, 350.06183428411845, 354.60815798542626, 6256.7497300108, 6278.811635650932, 6305.558610897239, 6322.968385158068, 6362.204724409449, 6217.0, 6232.626042437446, 6233.3143354231, 6236.594621349609, 6240.282367527724, 4616.884577885546, 4772.498887616803, 4782.378290822206, 4790.712557246559, 4800.3279540864305, 4755.453122890877, 4782.0, 4792.808287668489, 4798.256270278112, 4799.952000480003, 4728.0, 4741.431028276595, 4741.786619602109, 4752.192127338343, 4762.071396077767, 4703.341532185496, 4728.078024785168, 4739.976300118512, 4749.050189962004, 4753.572178503917, 4115.8971025724295, 4127.277726397899, 4129.938050929239, 4136.772477513736, 4143.606357396043, 5925.2889653241455, 5933.554983376264, 5953.255843019622, 5968.283805943272, 5990.161377407167, 5311.282976798121, 5518.19986102013, 5523.944760552424, 5526.364468086182, 5529.281193444866, 6603.570767900071, 6606.0, 6626.939689649681, 6627.469802415843, 6628.105205797252, 4489.59593636571, 4520.457545094577, 4524.479684836253, 4528.615067719248, 4529.705569137996, 6864.759733409307, 6921.446284297244, 6935.514513984023, 6971.0, 6971.825704357381, 4677.0, 4678.719276843332, 4680.180968330528, 4686.437627484655, 4697.718136911796, 4528.230200865861, 4647.930281045787, 4661.254199328091, 4679.344891715163, 4707.599854012379, 5452.318460192476, 5479.369872464717, 5493.23094766733, 5497.367802702661, 5511.448855114457, 6605.768798092044, 6633.369829866155, 6640.568363056386, 6663.4669226461765, 6670.466362690973, 1645.7202275613174, 1674.2298542670264, 1675.4219794170992, 1675.4554769699896, 1675.656490419461, 1079.6383211624193, 1093.5953697132113, 1100.5652767156928, 1107.9667609971714, 1125.943702814856, 6327.462165715873, 6353.30113687494, 6355.745770169141, 6376.489880809524, 6381.1385462962835, 6785.830354241085, 6790.219124800612, 6831.248562658104, 6843.213030501556, 6862.965685171542, 6083.726232319556, 6251.12484252205, 6298.212723409574, 6417.871642567123, 6418.390252925965, 3708.0, 3737.0, 3762.830672619739, 3768.8680896168503, 3769.754965927206, 7211.67547460355, 7222.313880181375, 7289.2346303638415, 7292.781216563511, 7315.30504602062, 7090.645467726593, 7094.893576596355, 7106.2183159852375, 7121.216666166718, 7135.143782746104, 7017.4386049116965, 7245.637718114073, 7273.636318184175, 7280.344768970924, 7288.854222915512, 6870.725170993104, 6891.896621550781, 6893.827654308682, 6894.551854129666, 6899.6205208714, 6816.386525212754, 6817.522773405814, 6826.556273842184, 6837.6239306836615, 6854.828629284308, 7261.564306141649, 7272.0, 7275.1997280298065, 7276.163241227327, 7279.599622020628, 4502.684812063124, 4629.86110416688, 4636.327732478839, 4665.766711664471, 4667.9766601166775, 6831.351021652935, 6845.178578570603, 6845.247022827584, 6875.5874647521305, 6884.896726549206, 6602.537822352389, 6637.966810165918, 6639.103720997604, 6651.201855777144, 6655.035019922181, 6596.934030659632, 6643.0, 6652.900206497004, 6653.900191497229, 6656.567323123982, 6409.038644203407, 6544.312847150981, 6545.443637290884, 6551.836204094936, 6564.113844630913, 6666.766663166766, 6667.166604174478, 6685.799426017227, 6695.832604184934, 6705.329467053256, 6490.0, 6499.1876015498065, 6505.186851643544, 6521.282658907421, 6526.184226971629], "unit": "score", "name": "prototype.html", "value": 5002.9775874237275}, {"lowerIsBetter": false, "replicates": [576.0696475192565, 594.0791772752235, 626.9090981807637, 697.8081027717378, 747.9790086531884, 12961.351932403377, 12962.611121666341, 13104.41030153643, 13197.472101115956, 13273.933630331847, 11451.312921224733, 11633.069354451645, 11642.126840486955, 11705.648830535098, 11783.528658853636, 832.5129799067538, 848.8259906719107, 849.2399302624148, 849.6771226933756, 850.9531975741331, 684.9246582875879, 833.3916241143938, 849.7918010087507, 851.0638297872322, 852.6546748566809, 881.568031664483, 887.077439462961, 892.7366426904078, 893.3791015244408, 894.4946105450432, 879.5821984557348, 884.2307192742292, 885.2077390735288, 886.3352485635774, 886.4814083761007, 645.6771614192903, 649.217692680319, 651.1437459740426, 651.3128649275013, 652.139176287301, 12523.43644535989, 12543.372831358396, 12597.307148106851, 12603.117781755282, 12622.747545049047, 12825.67935801603, 12962.935185324013, 13171.078024538287, 13254.072214944958, 13268.800967985488, 9481.47851868147, 9516.0, 9586.401589269439, 9685.225181985425, 9757.804843903154, 3281.1633033576522, 3332.96667033329, 3353.262282297915, 3375.257443362481, 3380.5605271314816, 45927.0, 45986.31020534695, 46086.30870536945, 46089.30866037046, 46235.0, 9496.916844604966, 9564.378315409476, 9651.420914744996, 9736.561854716554, 9833.36083154607, 18564.44306670802, 18633.7204941926, 18718.625627487647, 18754.906225469058, 18801.717974230396, 6859.2454829968665, 6998.545094568837, 7063.293670632998, 7114.857702845914, 7124.8575028499135, 3986.9202615948097, 4061.878143655695, 4098.897527561835, 4116.0, 4117.300058989979, 2906.084583356236, 2907.941841163165, 2917.5769513420437, 2923.4007028559095, 2929.1066224801216, 550.3313474128953, 570.5920267009109, 571.3771988532519, 580.115324130704, 584.9005669036189, 549.6262541471758, 559.7509108446784, 561.2731512691075, 570.7174948400568, 571.44855214718, 7883.36933045355, 7975.202479751978, 8082.151374105634, 8186.754397368089, 8199.918000820035, 547.9835604931858, 608.4949491921783, 633.9033472093305, 641.8940874755613, 645.6384424722171, 3641.781493110369, 3654.1778099927838, 3693.1505753676806, 3777.036855601804, 3806.2958352704286, 53660.0, 58777.11834322489, 58822.70588647029, 59384.0, 59469.70265148646, 48639.756801215764, 48759.26861097087, 49022.75488622534, 49482.50517494851, 49744.75127624339, 45056.3241551377, 45253.54746452559, 45915.77042114835, 45999.31001034987, 46004.0, 7928.246816552418, 8134.674613015413, 8154.266116049584, 8206.097329293654, 8326.875096873431, 32976.505352419255, 33266.83366583152, 33330.33339333248, 34175.65824341824, 34433.31133377369, 38592.0, 40553.59446405498, 41900.580994189666, 42126.578734212264, 42144.78927605342, 9738.902610973799, 10088.243381746544, 10097.253861990404, 10161.136303413998, 10292.536835842555, 10874.94562527214, 10905.781884362426, 10935.890641093487, 11112.555497779998, 11186.161037922026, 10528.578856845641, 10598.629047983284, 10801.189910756882, 10881.78236435251, 10985.285956412808, 10911.181661375269, 11044.779104418027, 11146.386948717898, 11328.773424531628, 11573.421328933688, 10811.513481893177, 10965.61620343284, 10969.945150274198, 11213.271137376045, 11263.380514071478, 9168.083191680778, 9363.157315841607, 9426.434413935185, 9588.089131532493, 9631.855522167032, 7915.722949696733, 8142.715004974797, 8195.590220488832, 8588.26999705032, 8733.30133589324], "unit": "score", "name": "yui.html", "value": 6039.037363587896}], "name": "dromaeo_css", "value": 6801.017347024441}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 114.0, 113.0, 111.0, 124.0, 110.0, 110.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [158.0, 129.0, 154.0, 171.0, 131.0, 156.0, 157.0, 137.0, 167.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 163.0, 162.0, 162.0, 161.0, 163.0, 174.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 77.0, 78.0, 75.0, 76.0, 77.0, 130.0, 77.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 145.0, 94.0, 94.0, 94.0, 155.0, 92.0, 94.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 149.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 60.0, 58.0, 58.0, 57.0, 59.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 84.0, 83.0, 83.0, 82.0, 82.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 118.0, 137.0, 119.0, 115.0, 121.0, 116.0, 117.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [135.0, 144.0, 143.0, 142.0, 146.0, 133.0, 150.0, 144.0, 146.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 67.0, 70.0, 67.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1519.8999999999999}]} 07:48:09 INFO - Return code: 0 07:48:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:09 ERROR - # TBPL SUCCESS # 07:48:09 INFO - Running post-action listener: _resource_record_post_action 07:48:09 INFO - Running post-run listener: _resource_record_post_run 07:48:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541020160; Read time: 12; Write time: 568116 07:48:11 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241209344; Read time: 0; Write time: 364592 07:48:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295948288; Read time: 12; Write time: 202516 07:48:11 INFO - Running post-run listener: _upload_blobber_files 07:48:11 INFO - Blob upload gear active. 07:48:11 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:48:11 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:48:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:48:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:12 INFO - (blobuploader) - INFO - Done attempting. 07:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:48:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:13 INFO - (blobuploader) - INFO - Done attempting. 07:48:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:13 INFO - Return code: 0 07:48:13 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:48:13 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf3763d98257f92c8bbb414b7bc5fe38959f057a221c44e5548cca985b1afcd099a7bb244f984b03aabcc929427224f0d0e41a281702ef84fa4efbd7ab4e41c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ca5b54abaf66d3ab7201fc3297e97f19d0d43c9932e05acdab7628f3e750b8eeb4771f460f7f9b58cbdabd08eadb5109e7578ec05f7500d4ee7fe873b16535"} 07:48:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:48:13 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:48:13 INFO - Contents: 07:48:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf3763d98257f92c8bbb414b7bc5fe38959f057a221c44e5548cca985b1afcd099a7bb244f984b03aabcc929427224f0d0e41a281702ef84fa4efbd7ab4e41c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ca5b54abaf66d3ab7201fc3297e97f19d0d43c9932e05acdab7628f3e750b8eeb4771f460f7f9b58cbdabd08eadb5109e7578ec05f7500d4ee7fe873b16535"} 07:48:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:13 INFO - Copying logs to upload dir... 07:48:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:48:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.169151 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-11 07:48:13.120930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:13.124084) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf3763d98257f92c8bbb414b7bc5fe38959f057a221c44e5548cca985b1afcd099a7bb244f984b03aabcc929427224f0d0e41a281702ef84fa4efbd7ab4e41c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ca5b54abaf66d3ab7201fc3297e97f19d0d43c9932e05acdab7628f3e750b8eeb4771f460f7f9b58cbdabd08eadb5109e7578ec05f7500d4ee7fe873b16535"} build_url:https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/VWKgUC8fSQSdlU0-s3L-Gg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf3763d98257f92c8bbb414b7bc5fe38959f057a221c44e5548cca985b1afcd099a7bb244f984b03aabcc929427224f0d0e41a281702ef84fa4efbd7ab4e41c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6ca5b54abaf66d3ab7201fc3297e97f19d0d43c9932e05acdab7628f3e750b8eeb4771f460f7f9b58cbdabd08eadb5109e7578ec05f7500d4ee7fe873b16535"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:13.154681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:13.155484) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1457710065.347240-70598299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:13.238413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:48:13.239134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:48:13.239927) ========= ========= Total master_lag: 0.28 =========