builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1456898375.48 results: success (0) buildid: 20160301193336 builduid: 5b0358802bde4fab8e4ace8519e3be93 revision: 3bd640d45525f634e2f24049fbfe051683581c88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.482360) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.482933) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.483347) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.507423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.507784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.531288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.531595) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.580883) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.581188) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.581597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.581916) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 21:59:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.2M=0s 2016-03-01 21:59:36 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158294 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.753152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.753733) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:35.804354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 21:59:35.804808) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3bd640d45525f634e2f24049fbfe051683581c88 --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 3bd640d45525f634e2f24049fbfe051683581c88 --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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 21:59:36,468 truncating revision to first 12 chars 2016-03-01 21:59:36,468 Setting DEBUG logging. 2016-03-01 21:59:36,468 attempt 1/10 2016-03-01 21:59:36,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3bd640d45525?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 21:59:36,759 unpacking tar archive at: mozilla-inbound-3bd640d45525/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 21:59:36.826527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:36.826948) ========= echo 3bd640d45525f634e2f24049fbfe051683581c88 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bd640d45525f634e2f24049fbfe051683581c88'] 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bd640d45525f634e2f24049fbfe051683581c88 program finished with exit code 0 elapsedTime=0.004627 script_repo_revision: '3bd640d45525f634e2f24049fbfe051683581c88' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:36.878495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:36.878846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:36.888824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-01 21:59:36.889138) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:37 INFO - MultiFileLogger online at 20160301 21:59:37 in /builds/slave/test-pgo 21:59:37 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 21:59:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:37 INFO - {'append_to_log': False, 21:59:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:37 INFO - 'branch': 'Mozilla-Inbound', 21:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:37 INFO - 'config_files': ('talos/linux_config.py',), 21:59:37 INFO - 'default_actions': ('clobber', 21:59:37 INFO - 'read-buildbot-config', 21:59:37 INFO - 'download-and-extract', 21:59:37 INFO - 'populate-webroot', 21:59:37 INFO - 'create-virtualenv', 21:59:37 INFO - 'install', 21:59:37 INFO - 'run-tests'), 21:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:37 INFO - 'download_minidump_stackwalk': True, 21:59:37 INFO - 'download_symbols': 'ondemand', 21:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:37 INFO - 'installer_path': 'installer.exe', 21:59:37 INFO - 'log_level': 'info', 21:59:37 INFO - 'log_name': 'talos', 21:59:37 INFO - 'log_to_console': True, 21:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:37 INFO - 'opt_config_files': (), 21:59:37 INFO - 'pip_index': False, 21:59:37 INFO - 'sps_profile': False, 21:59:37 INFO - 'sps_profile_interval': 0, 21:59:37 INFO - 'suite': 'dromaeojs-e10s', 21:59:37 INFO - 'system_bits': '32', 21:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:37 INFO - 'title': 'talos-linux64-ix-068', 21:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:37 INFO - 'use_talos_json': True, 21:59:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:37 INFO - 'work_dir': 'build'} 21:59:37 INFO - ##### 21:59:37 INFO - ##### Running clobber step. 21:59:37 INFO - ##### 21:59:37 INFO - Running pre-action listener: _resource_record_pre_action 21:59:37 INFO - Running main action method: clobber 21:59:37 INFO - rmtree: /builds/slave/test-pgo/build 21:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:38 INFO - Running post-action listener: _resource_record_post_action 21:59:38 INFO - ##### 21:59:38 INFO - ##### Running read-buildbot-config step. 21:59:38 INFO - ##### 21:59:38 INFO - Running pre-action listener: _resource_record_pre_action 21:59:38 INFO - Running main action method: read_buildbot_config 21:59:38 INFO - Using buildbot properties: 21:59:38 INFO - { 21:59:38 INFO - "project": "", 21:59:38 INFO - "product": "firefox", 21:59:38 INFO - "script_repo_revision": "production", 21:59:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:59:38 INFO - "repository": "", 21:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:59:38 INFO - "buildid": "20160301193336", 21:59:38 INFO - "pgo_build": "True", 21:59:38 INFO - "basedir": "/builds/slave/test-pgo", 21:59:38 INFO - "buildnumber": 369, 21:59:38 INFO - "slavename": "talos-linux64-ix-068", 21:59:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:59:38 INFO - "platform": "ubuntu64_hw", 21:59:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:38 INFO - "branch": "mozilla-inbound", 21:59:38 INFO - "repo_path": "integration/mozilla-inbound", 21:59:38 INFO - "revision": "3bd640d45525f634e2f24049fbfe051683581c88", 21:59:38 INFO - "stage_platform": "linux64-pgo", 21:59:38 INFO - "builduid": "5b0358802bde4fab8e4ace8519e3be93", 21:59:38 INFO - "slavebuilddir": "test" 21:59:38 INFO - } 21:59:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:59:38 INFO - Running post-action listener: _resource_record_post_action 21:59:38 INFO - ##### 21:59:38 INFO - ##### Running download-and-extract step. 21:59:38 INFO - ##### 21:59:38 INFO - Running pre-action listener: _resource_record_pre_action 21:59:38 INFO - Running main action method: download_and_extract 21:59:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:38 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:59:38 INFO - Downloaded 1448 bytes. 21:59:38 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:38 INFO - Using the following test package requirements: 21:59:38 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'jsshell-linux-x86_64.zip'], 21:59:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:38 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:38 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:40 INFO - Downloaded 23394559 bytes. 21:59:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:41 INFO - Return code: 0 21:59:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:41 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:45 INFO - Downloaded 23394559 bytes. 21:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:47 INFO - Return code: 0 21:59: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')]} 21:59:47 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:48 INFO - Downloaded 10808456 bytes. 21:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:48 INFO - Return code: 0 21:59: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')]} 21:59:48 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:50 INFO - Downloaded 56148381 bytes. 21:59:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:50 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:50 INFO - Contents: 21:59:50 INFO - build_url:https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:50 INFO - Running post-action listener: _resource_record_post_action 21:59:50 INFO - Running post-action listener: set_extra_try_arguments 21:59:50 INFO - ##### 21:59:50 INFO - ##### Running populate-webroot step. 21:59:50 INFO - ##### 21:59:50 INFO - Running pre-action listener: _resource_record_pre_action 21:59:50 INFO - Running main action method: populate_webroot 21:59:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:50 INFO - '--tppagecycles', 21:59:50 INFO - '7'], 21:59:50 INFO - 'tests': ['tsvgm']}}, 21:59:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:59:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'tests': ['damp', 'tps']}, 21:59:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['damp', 'tps']}, 21:59:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:50 INFO - 'other': {'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'other_l64': {'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:50 INFO - 'ts_paint', 21:59:50 INFO - 'tpaint', 21:59:50 INFO - 'sessionrestore', 21:59:50 INFO - 'sessionrestore_no_auto_restore']}, 21:59:50 INFO - 'svgr': {'tests': ['tsvgx', 21:59:50 INFO - 'tsvgr_opacity', 21:59:50 INFO - 'tart', 21:59:50 INFO - 'tscrollx', 21:59:50 INFO - 'cart']}, 21:59:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['tsvgx', 21:59:50 INFO - 'tsvgr_opacity', 21:59:50 INFO - 'tart', 21:59:50 INFO - 'tscrollx', 21:59:50 INFO - 'cart']}, 21:59:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'tests': ['tp5o']}, 21:59:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'talos_options': ['--e10s'], 21:59:50 INFO - 'tests': ['tp5o']}, 21:59:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'talos_options': ['--xperf_path', 21:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:50 INFO - 'tests': ['tp5n']}, 21:59:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:50 INFO - 'talos_options': ['--e10s', 21:59:50 INFO - '--xperf_path', 21:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:50 INFO - 'tests': ['tp5n']}}, 21:59:50 INFO - 'talos.zip': {'path': '', 21:59:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:50 INFO - Running post-action listener: _resource_record_post_action 21:59:50 INFO - ##### 21:59:50 INFO - ##### Running create-virtualenv step. 21:59:50 INFO - ##### 21:59:50 INFO - Running pre-action listener: _resource_record_pre_action 21:59:50 INFO - Running main action method: create_virtualenv 21:59:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:50 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 21:59:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:50 INFO - Using real prefix '/usr' 21:59:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:53 INFO - Installing pip.................done. 21:59:53 INFO - Return code: 0 21:59:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 21:59:53 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 21:59:53 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 21:59:53 INFO - Using env: {'DISPLAY': ':0', 21:59:53 INFO - 'HOME': '/home/cltbld', 21:59:53 INFO - 'LANG': 'en_US.UTF-8', 21:59:53 INFO - 'LANGUAGE': 'en_US:en', 21:59:53 INFO - 'LOGNAME': 'cltbld', 21:59:53 INFO - 'MAIL': '/var/mail/cltbld', 21:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:53 INFO - 'MOZ_NO_REMOTE': '1', 21:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:53 INFO - 'NO_EM_RESTART': '1', 21:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:53 INFO - 'SHELL': '/bin/bash', 21:59:53 INFO - 'SHLVL': '1', 21:59:53 INFO - 'TERM': 'linux', 21:59:53 INFO - 'TMOUT': '86400', 21:59:53 INFO - 'USER': 'cltbld', 21:59:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 21:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:53 INFO - '_': '/tools/buildbot/bin/python'} 21:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:53 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 21:59:53 INFO - Cleaning up... 21:59:53 INFO - Return code: 0 21:59:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 21:59:53 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 21:59:53 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 21:59:53 INFO - Using env: {'DISPLAY': ':0', 21:59:53 INFO - 'HOME': '/home/cltbld', 21:59:53 INFO - 'LANG': 'en_US.UTF-8', 21:59:53 INFO - 'LANGUAGE': 'en_US:en', 21:59:53 INFO - 'LOGNAME': 'cltbld', 21:59:53 INFO - 'MAIL': '/var/mail/cltbld', 21:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:53 INFO - 'MOZ_NO_REMOTE': '1', 21:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:53 INFO - 'NO_EM_RESTART': '1', 21:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:53 INFO - 'SHELL': '/bin/bash', 21:59:53 INFO - 'SHLVL': '1', 21:59:53 INFO - 'TERM': 'linux', 21:59:53 INFO - 'TMOUT': '86400', 21:59:53 INFO - 'USER': 'cltbld', 21:59:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 21:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:53 INFO - '_': '/tools/buildbot/bin/python'} 21:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:53 INFO - Downloading/unpacking psutil>=0.7.1 21:59:53 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 21:59:53 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 21:59:53 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 21:59:53 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 21:59:53 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 21:59:53 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 21:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:55 INFO - Installing collected packages: psutil 21:59:55 INFO - Running setup.py install for psutil 21:59:55 INFO - building 'psutil._psutil_linux' extension 21:59:55 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 21:59:55 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 21:59:55 INFO - building 'psutil._psutil_posix' extension 21:59:55 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 21:59:56 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 21:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:56 INFO - Successfully installed psutil 21:59:56 INFO - Cleaning up... 21:59:56 INFO - Return code: 0 21:59:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 21:59:56 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 21:59:56 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 21:59:56 INFO - Using env: {'DISPLAY': ':0', 21:59:56 INFO - 'HOME': '/home/cltbld', 21:59:56 INFO - 'LANG': 'en_US.UTF-8', 21:59:56 INFO - 'LANGUAGE': 'en_US:en', 21:59:56 INFO - 'LOGNAME': 'cltbld', 21:59:56 INFO - 'MAIL': '/var/mail/cltbld', 21:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:56 INFO - 'MOZ_NO_REMOTE': '1', 21:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:56 INFO - 'NO_EM_RESTART': '1', 21:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:56 INFO - 'SHELL': '/bin/bash', 21:59:56 INFO - 'SHLVL': '1', 21:59:56 INFO - 'TERM': 'linux', 21:59:56 INFO - 'TMOUT': '86400', 21:59:56 INFO - 'USER': 'cltbld', 21:59:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 21:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:56 INFO - '_': '/tools/buildbot/bin/python'} 21:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:58 INFO - Installing collected packages: mozsystemmonitor 21:59:58 INFO - Running setup.py install for mozsystemmonitor 21:59:58 INFO - Successfully installed mozsystemmonitor 21:59:58 INFO - Cleaning up... 21:59:58 INFO - Return code: 0 21:59:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:58 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 21:59:58 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 21:59:58 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 21:59:58 INFO - Using env: {'DISPLAY': ':0', 21:59:58 INFO - 'HOME': '/home/cltbld', 21:59:58 INFO - 'LANG': 'en_US.UTF-8', 21:59:58 INFO - 'LANGUAGE': 'en_US:en', 21:59:58 INFO - 'LOGNAME': 'cltbld', 21:59:58 INFO - 'MAIL': '/var/mail/cltbld', 21:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:58 INFO - 'MOZ_NO_REMOTE': '1', 21:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:58 INFO - 'NO_EM_RESTART': '1', 21:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:58 INFO - 'SHELL': '/bin/bash', 21:59:58 INFO - 'SHLVL': '1', 21:59:58 INFO - 'TERM': 'linux', 21:59:58 INFO - 'TMOUT': '86400', 21:59:58 INFO - 'USER': 'cltbld', 21:59:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 21:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:58 INFO - '_': '/tools/buildbot/bin/python'} 21:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:58 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 21:59:58 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 21:59:58 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 21:59:58 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 21:59:58 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 21:59:58 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 22:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:01 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 22:00:01 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 22:00:01 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 22:00:01 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 22:00:01 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 22:00:01 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 22:00:01 INFO - Downloading docopt-0.6.1.tar.gz 22:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:01 INFO - Running setup.py install for blobuploader 22:00:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:01 INFO - Running setup.py install for requests 22:00:01 INFO - Running setup.py install for docopt 22:00:01 INFO - Successfully installed blobuploader requests docopt 22:00:01 INFO - Cleaning up... 22:00:01 INFO - Return code: 0 22:00:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:01 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')]} 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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')]} 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 22:00:01 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 22:00:01 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 22:00:01 INFO - Using env: {'DISPLAY': ':0', 22:00:01 INFO - 'HOME': '/home/cltbld', 22:00:01 INFO - 'LANG': 'en_US.UTF-8', 22:00:01 INFO - 'LANGUAGE': 'en_US:en', 22:00:01 INFO - 'LOGNAME': 'cltbld', 22:00:01 INFO - 'MAIL': '/var/mail/cltbld', 22:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:01 INFO - 'MOZ_NO_REMOTE': '1', 22:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:01 INFO - 'NO_EM_RESTART': '1', 22:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:01 INFO - 'SHELL': '/bin/bash', 22:00:01 INFO - 'SHLVL': '1', 22:00:01 INFO - 'TERM': 'linux', 22:00:01 INFO - 'TMOUT': '86400', 22:00:01 INFO - 'USER': 'cltbld', 22:00:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:01 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:02 INFO - Running setup.py (path:/tmp/pip-0f1nmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:02 INFO - Running setup.py (path:/tmp/pip-O3DXAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:02 INFO - Running setup.py (path:/tmp/pip-DrCNcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:02 INFO - Running setup.py (path:/tmp/pip-W9VHEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:02 INFO - Running setup.py (path:/tmp/pip-Gt7tMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:02 INFO - Running setup.py (path:/tmp/pip-ZjAIFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:02 INFO - Running setup.py (path:/tmp/pip-xa1jg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:02 INFO - Running setup.py (path:/tmp/pip-cup4uE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:02 INFO - Running setup.py (path:/tmp/pip-t7Ii0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:02 INFO - Running setup.py (path:/tmp/pip-b7VbU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:02 INFO - Running setup.py (path:/tmp/pip-b1Mp64-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:02 INFO - Running setup.py (path:/tmp/pip-TjfUxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:03 INFO - Running setup.py (path:/tmp/pip-KZ7SW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:03 INFO - Running setup.py (path:/tmp/pip-bEfCRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:03 INFO - Running setup.py (path:/tmp/pip-DM1oSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:03 INFO - Running setup.py (path:/tmp/pip-JrcEUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:03 INFO - Running setup.py (path:/tmp/pip-i2PBLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:03 INFO - Running setup.py install for manifestparser 22:00:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:03 INFO - Running setup.py install for mozcrash 22:00:03 INFO - Running setup.py install for mozdebug 22:00:03 INFO - Running setup.py install for mozdevice 22:00:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:03 INFO - Running setup.py install for mozfile 22:00:03 INFO - Running setup.py install for mozhttpd 22:00:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozinfo 22:00:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozInstall 22:00:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozleak 22:00:04 INFO - Running setup.py install for mozlog 22:00:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for moznetwork 22:00:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozprocess 22:00:04 INFO - Running setup.py install for mozprofile 22:00:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozrunner 22:00:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:04 INFO - Running setup.py install for mozscreenshot 22:00:04 INFO - Running setup.py install for moztest 22:00:05 INFO - Running setup.py install for mozversion 22:00:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:05 INFO - Cleaning up... 22:00:05 INFO - Return code: 0 22:00:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:05 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 22:00:05 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 22:00:05 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 22:00:05 INFO - Using env: {'DISPLAY': ':0', 22:00:05 INFO - 'HOME': '/home/cltbld', 22:00:05 INFO - 'LANG': 'en_US.UTF-8', 22:00:05 INFO - 'LANGUAGE': 'en_US:en', 22:00:05 INFO - 'LOGNAME': 'cltbld', 22:00:05 INFO - 'MAIL': '/var/mail/cltbld', 22:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:05 INFO - 'MOZ_NO_REMOTE': '1', 22:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:05 INFO - 'NO_EM_RESTART': '1', 22:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:05 INFO - 'SHELL': '/bin/bash', 22:00:05 INFO - 'SHLVL': '1', 22:00:05 INFO - 'TERM': 'linux', 22:00:05 INFO - 'TMOUT': '86400', 22:00:05 INFO - 'USER': 'cltbld', 22:00:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:05 INFO - '_': '/tools/buildbot/bin/python'} 22:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:05 INFO - Running setup.py (path:/tmp/pip-XcUT2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:05 INFO - Running setup.py (path:/tmp/pip-XMfoKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:05 INFO - Running setup.py (path:/tmp/pip-uWZHXk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:05 INFO - Running setup.py (path:/tmp/pip-qrhWzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:05 INFO - Running setup.py (path:/tmp/pip-vuIeKx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:05 INFO - Running setup.py (path:/tmp/pip-leJr6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:05 INFO - Running setup.py (path:/tmp/pip-y5tJee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:05 INFO - Running setup.py (path:/tmp/pip-OLfAaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:05 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)) 22:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:05 INFO - Running setup.py (path:/tmp/pip-i3h3Zu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:06 INFO - Running setup.py (path:/tmp/pip-XZopoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:06 INFO - Running setup.py (path:/tmp/pip-p8JUDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:06 INFO - Running setup.py (path:/tmp/pip-YbXJ7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:06 INFO - Running setup.py (path:/tmp/pip-tII5Ew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:06 INFO - Running setup.py (path:/tmp/pip-5L9a9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:06 INFO - Running setup.py (path:/tmp/pip-a1YbjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:06 INFO - Running setup.py (path:/tmp/pip-k8dyCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:06 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)) 22:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:06 INFO - Running setup.py (path:/tmp/pip-l31TEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:06 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)) 22:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:06 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)) 22:00:06 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)) 22:00:06 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)) 22:00:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:08 INFO - Downloading blessings-1.6.tar.gz 22:00:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:08 INFO - Installing collected packages: blessings 22:00:08 INFO - Running setup.py install for blessings 22:00:08 INFO - Successfully installed blessings 22:00:08 INFO - Cleaning up... 22:00:08 INFO - Return code: 0 22:00:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:08 INFO - Reading from file tmpfile_stdout 22:00:08 INFO - Current package versions: 22:00:08 INFO - argparse == 1.2.1 22:00:08 INFO - blessings == 1.6 22:00:08 INFO - blobuploader == 1.2.4 22:00:08 INFO - docopt == 0.6.1 22:00:08 INFO - manifestparser == 1.1 22:00:08 INFO - mozInstall == 1.12 22:00:08 INFO - mozcrash == 0.16 22:00:08 INFO - mozdebug == 0.1 22:00:08 INFO - mozdevice == 0.48 22:00:08 INFO - mozfile == 1.2 22:00:08 INFO - mozhttpd == 0.7 22:00:08 INFO - mozinfo == 0.9 22:00:08 INFO - mozleak == 0.1 22:00:08 INFO - mozlog == 3.1 22:00:08 INFO - moznetwork == 0.27 22:00:08 INFO - mozprocess == 0.22 22:00:08 INFO - mozprofile == 0.28 22:00:08 INFO - mozrunner == 6.11 22:00:08 INFO - mozscreenshot == 0.1 22:00:08 INFO - mozsystemmonitor == 0.0 22:00:08 INFO - moztest == 0.7 22:00:08 INFO - mozversion == 1.4 22:00:08 INFO - psutil == 3.1.1 22:00:08 INFO - requests == 1.2.3 22:00:08 INFO - wsgiref == 0.1.2 22:00:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:08 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 22:00:08 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 22:00:08 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 22:00:08 INFO - Using env: {'DISPLAY': ':0', 22:00:08 INFO - 'HOME': '/home/cltbld', 22:00:08 INFO - 'LANG': 'en_US.UTF-8', 22:00:08 INFO - 'LANGUAGE': 'en_US:en', 22:00:08 INFO - 'LOGNAME': 'cltbld', 22:00:08 INFO - 'MAIL': '/var/mail/cltbld', 22:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:08 INFO - 'MOZ_NO_REMOTE': '1', 22:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:08 INFO - 'NO_EM_RESTART': '1', 22:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:08 INFO - 'SHELL': '/bin/bash', 22:00:08 INFO - 'SHLVL': '1', 22:00:08 INFO - 'TERM': 'linux', 22:00:08 INFO - 'TMOUT': '86400', 22:00:08 INFO - 'USER': 'cltbld', 22:00:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:08 INFO - '_': '/tools/buildbot/bin/python'} 22:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 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)) 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 22:00:09 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 22:00:09 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 22:00:09 INFO - Using env: {'DISPLAY': ':0', 22:00:09 INFO - 'HOME': '/home/cltbld', 22:00:09 INFO - 'LANG': 'en_US.UTF-8', 22:00:09 INFO - 'LANGUAGE': 'en_US:en', 22:00:09 INFO - 'LOGNAME': 'cltbld', 22:00:09 INFO - 'MAIL': '/var/mail/cltbld', 22:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:09 INFO - 'MOZ_NO_REMOTE': '1', 22:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:09 INFO - 'NO_EM_RESTART': '1', 22:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:09 INFO - 'SHELL': '/bin/bash', 22:00:09 INFO - 'SHLVL': '1', 22:00:09 INFO - 'TERM': 'linux', 22:00:09 INFO - 'TMOUT': '86400', 22:00:09 INFO - 'USER': 'cltbld', 22:00:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:09 INFO - '_': '/tools/buildbot/bin/python'} 22:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:09 INFO - Downloading/unpacking jsonschema 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:11 INFO - warning: no files found matching '*.txt' 22:00:11 INFO - no previously-included directories found matching 'build' 22:00:11 INFO - no previously-included directories found matching 'dist' 22:00:11 INFO - no previously-included directories found matching '.git*' 22:00:11 INFO - Installing collected packages: jsonschema, functools32 22:00:11 INFO - Running setup.py install for functools32 22:00:11 INFO - warning: no files found matching '*.txt' 22:00:11 INFO - no previously-included directories found matching 'build' 22:00:11 INFO - no previously-included directories found matching 'dist' 22:00:11 INFO - no previously-included directories found matching '.git*' 22:00:11 INFO - Successfully installed jsonschema functools32 22:00:11 INFO - Cleaning up... 22:00:11 INFO - Return code: 0 22:00:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00: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')]} 22:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:11 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 0x7f2bcaf27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', '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 22:00:11 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 22:00:11 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 22:00:11 INFO - Using env: {'DISPLAY': ':0', 22:00:11 INFO - 'HOME': '/home/cltbld', 22:00:11 INFO - 'LANG': 'en_US.UTF-8', 22:00:11 INFO - 'LANGUAGE': 'en_US:en', 22:00:11 INFO - 'LOGNAME': 'cltbld', 22:00:11 INFO - 'MAIL': '/var/mail/cltbld', 22:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:11 INFO - 'MOZ_NO_REMOTE': '1', 22:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:11 INFO - 'NO_EM_RESTART': '1', 22:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:11 INFO - 'SHELL': '/bin/bash', 22:00:11 INFO - 'SHLVL': '1', 22:00:11 INFO - 'TERM': 'linux', 22:00:11 INFO - 'TMOUT': '86400', 22:00:11 INFO - 'USER': 'cltbld', 22:00:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:11 INFO - '_': '/tools/buildbot/bin/python'} 22:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:11 INFO - Downloading/unpacking flake8 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:11 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 22:00:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:13 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 22:00:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:14 INFO - no previously-included directories found matching 'docs/_build' 22:00:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:14 INFO - Running setup.py install for pep8 22:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:14 INFO - no previously-included directories found matching 'docs/_build' 22:00:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:14 INFO - Cleaning up... 22:00:14 INFO - Return code: 0 22:00:14 INFO - Running post-action listener: _resource_record_post_action 22:00:14 INFO - Running post-action listener: _start_resource_monitoring 22:00:14 INFO - Starting resource monitoring. 22:00:14 INFO - ##### 22:00:14 INFO - ##### Running install step. 22:00:14 INFO - ##### 22:00:14 INFO - Running pre-action listener: _resource_record_pre_action 22:00:14 INFO - Running main action method: install 22:00:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:14 INFO - Reading from file tmpfile_stdout 22:00:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:14 INFO - Reading from file tmpfile_stdout 22:00:14 INFO - Output received: 22:00:14 INFO - Usage: mozinstall [options] installer 22:00:14 INFO - Options: 22:00:14 INFO - -h, --help show this help message and exit 22:00:14 INFO - -d DEST, --destination=DEST 22:00:14 INFO - Directory to install application into. [default: 22:00:14 INFO - "/builds/slave/test-pgo"] 22:00:14 INFO - --app=APP Application being installed. [default: firefox] 22:00:14 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:00:31 INFO - Reading from file tmpfile_stdout 22:00:31 INFO - Output received: 22:00:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:31 INFO - Running post-action listener: _resource_record_post_action 22:00:31 INFO - ##### 22:00:31 INFO - ##### Running run-tests step. 22:00:31 INFO - ##### 22:00:31 INFO - Running pre-action listener: _resource_record_pre_action 22:00:31 INFO - Running main action method: run_tests 22:00:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:31 INFO - Python 2.7.3 22:00:31 INFO - Return code: 0 22:00:31 INFO - grabbing minidump binary from tooltool 22:00:31 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')]} 22:00:31 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 0x25dc8c0>, '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 0x25dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ddc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:31 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 22:00:31 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 22:00:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:31 INFO - Return code: 0 22:00:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:00:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:00:32 INFO - Return code: 0 22:00:32 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:00:32 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 22:00:32 INFO - Using env: {'DISPLAY': ':0', 22:00:32 INFO - 'HOME': '/home/cltbld', 22:00:32 INFO - 'LANG': 'en_US.UTF-8', 22:00:32 INFO - 'LANGUAGE': 'en_US:en', 22:00:32 INFO - 'LOGNAME': 'cltbld', 22:00:32 INFO - 'MAIL': '/var/mail/cltbld', 22:00:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:32 INFO - 'MOZ_NO_REMOTE': '1', 22:00:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:32 INFO - 'NO_EM_RESTART': '1', 22:00:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:32 INFO - 'SHELL': '/bin/bash', 22:00:32 INFO - 'SHLVL': '1', 22:00:32 INFO - 'TERM': 'linux', 22:00:32 INFO - 'TMOUT': '86400', 22:00:32 INFO - 'USER': 'cltbld', 22:00:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541', 22:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:32 INFO - '_': '/tools/buildbot/bin/python'} 22:00:32 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 22:00:32 INFO - mozversion application_buildid: 20160301193336 22:00:32 INFO - mozversion application_changeset: 3bd640d45525f634e2f24049fbfe051683581c88 22:00:32 INFO - mozversion application_display_name: Nightly 22:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:32 INFO - mozversion application_name: Firefox 22:00:32 INFO - mozversion application_remotingname: firefox 22:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:32 INFO - mozversion application_vendor: Mozilla 22:00:32 INFO - mozversion application_version: 47.0a1 22:00:32 INFO - mozversion platform_buildid: 20160301193336 22:00:32 INFO - mozversion platform_changeset: 3bd640d45525f634e2f24049fbfe051683581c88 22:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:32 INFO - mozversion platform_version: 47.0a1 22:00:32 INFO - using testdate: 1456898432 22:00:32 INFO - actual date: 1456898432 22:00:32 INFO - starting webserver on 'localhost:48169' 22:00:32 INFO - SUITE-START | Running 2 tests 22:00:32 INFO - TEST-START | dromaeo_css 22:00:32 INFO - operating with platform_type : linux_ 22:00:32 INFO - Initialising browser for dromaeo_css test... 22:00:32 INFO - TEST-INFO | started process 19244 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2IfHF/profile http://localhost:48169/getInfo.html) 22:00:36 INFO - PROCESS | 19244 | 22:00:36 INFO - PROCESS | 19244 | (process:19327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:37 INFO - PROCESS | 19244 | __metrics Screen width/height:1600/1200 22:00:37 INFO - PROCESS | 19244 | colorDepth:24 22:00:37 INFO - PROCESS | 19244 | Browser inner width/height: 1024/697 22:00:37 INFO - PROCESS | 19244 | __metrics 22:00:37 ERROR - PROCESS | 19244 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:00:38 INFO - TEST-INFO | 19244: exit 0 22:00:38 INFO - Browser initialized. 22:00:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:38 INFO - TEST-INFO | started process 19378 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2IfHF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:40 INFO - PROCESS | 19378 | 22:00:40 INFO - PROCESS | 19378 | (process:19438): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:00:50 INFO - PROCESS | 19378 | RSS: Main: 160759808 22:00:50 INFO - PROCESS | 19378 | 22:01:40 INFO - PROCESS | 19378 | 1456898500096 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] 22:03:48 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48169/tests/dromaeo/cssquery-ext.html) 22:03:49 INFO - PROCESS | 19378 | RSS: Main: 169566208 22:03:49 INFO - PROCESS | 19378 | 22:06:51 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-ext.html (next: http://localhost:48169/tests/dromaeo/cssquery-jquery.html) 22:06:52 INFO - PROCESS | 19378 | RSS: Main: 165613568 22:06:52 INFO - PROCESS | 19378 | 22:09:54 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48169/tests/dromaeo/cssquery-mootools.html) 22:09:54 INFO - PROCESS | 19378 | RSS: Main: 166559744 22:09:54 INFO - PROCESS | 19378 | 22:12:56 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48169/tests/dromaeo/cssquery-prototype.html) 22:12:57 INFO - PROCESS | 19378 | RSS: Main: 165138432 22:12:57 INFO - PROCESS | 19378 | 22:15:59 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48169/tests/dromaeo/cssquery-yui.html) 22:16:00 INFO - PROCESS | 19378 | RSS: Main: 164753408 22:16:00 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | Cycle 1(1): loaded http://localhost:48169/tests/dromaeo/cssquery-yui.html (next: http://localhost:48169/tests/dromaeo/cssquery-dojo.html) 22:19:02 INFO - PROCESS | 19378 | RSS: Main: 168648704 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | __start_tp_report 22:19:02 INFO - PROCESS | 19378 | _x_x_mozilla_page_load 22:19:02 INFO - PROCESS | 19378 | _x_x_mozilla_page_load_details 22:19:02 INFO - PROCESS | 19378 | |i|pagename|runs| 22:19:02 INFO - PROCESS | 19378 | |0;dojo.html;3115.1277642260175;3140.71733543981;3159.4470967580683;3166.445871972405;3191.2021994501374;5116.053530096935;5196.610254230929;5236.738163091844;5242.135047717127;5321.201819727043;5275.261463395128;5275.762590683419;5341.1988201769755;5344.652597581165;5352.304200453946;4800.735959522225;4813.7593120343845;4823.493533179018;4916.1642520771375;4988.176950803113;4971.477994810547;4973.726445045521;5006.799728010875;5011.2483127530795;5031.647784655075;4662.8134874604975;4675.158471475133;4692.97653511732;4705.529447055302;4729.787159577827;4741;4761.285807128924;4776;4807.975960120212;4809.591184749301;4635.072985402933;4711.316859055452;4758.762061896891;4760.595349395306;4798.47216806151;5078.822241221539;5113.795448182068;5126.333576635051;5138;5167.147420675584;5645.604807663465;5646.520045796112;5652.971735141339;5656.4060773619;5703.17303990919;5639.295088113986;5681.204631351614;5692.17463467799;5709.65742055478;5768.307803063617;5368.677879327252;5393.622446428752;5401.567874570064;5403.297571315782;5407.459254074561;5830.679312637845;5834.329052159056;5834.5624078194305;5854.707264636836;5859.44335288147;5496;5516.972415137979;5528.336599607992;5572.721363931787;5610.635308704921;5675.3757086720425;5676.063449530781;5677.290338707661;5693.9750844847495;5701.173329867146;5531.640443371168;5578.442155784389;5666.46168613981;5666.688332141689;5718.942810571841;5461.453854614586;5512.6968016759465;5530.778768849201;5561.749721262553;5642.774289028393;4361.345798130305;4368.170047690928;4371.344298355272;4393.20922234001;4402.9432936095745;3878.127421330178;3885.320068987916;3895.49358583388;3896.902577435587;3916.099297161669;5249.501297376743;5273.604479664041;5293.788248470018;5315.760790764348;5329.493698098674;5673.290838645169;5711.400302968129;5728.656280623176;5729.770809167587;5743.10981797822;5335.919961200585;5346.652467589594;5348.438413966555;5351.839444816662;5364.22218778275;4671.43942726875;4782.545658162469;4821.686590371614;4831.396075490564;4853.126437241331;5836.153757705109;5837.066069428871;5846.4153584642045;5851.32709738377;5855.970720146372;5518.503334699896;5558.194061861089;5558.333000039859;5574.749136288958;5587.916181257366;5641.294838145232;5756.136579513107;5797.333306669787;5847.38602446737;5893.616914900518;5611.523020543136;5633.267675202197;5633.690147041788;5643.3792282848035;5647.29408823897;5559.777608895599;5773.1051686988585;5783.826485205451;5784.305883294031;5785.508231800344;5445.26488924006;5480.314960629921;5482.23248745168;5545.112781954868;5574.693391863324;5476.72616369172;5522.861928451821;5544.861378465571;5573.888522229451;5642.435756424489;5392.973035134799;5398.838034858961;5402.918956215739;5402.972985135207;5415.5938304626525;5494.230807687007;5516.724163791714;5584.944150558605;5585.441455854382;5622.100463925753;5415.864603384947;5440.782368705366;5446.074167391474;5450.291462109901;5450.454954504517 22:19:02 INFO - PROCESS | 19378 | |1;ext.html;516.8087807511221;520.7292208051813;535.7160704826441;547.113675845131;595.5325069820192;34272.82863585685;34616.480752788695;34658.65341346589;34905.825470872674;34965.82517087417;35896.46155307666;36062.459063114075;36274.63725362746;36503;36517.26965460696;8345.873307103524;8611.397202195849;8665.220130188281;8667.913320866774;8672;8419.747407577752;8545.359098067638;8555.786105347353;8566.3146948244;8610.784730381727;8565.271951884097;8570.828583428327;8601.397902146853;8615.439996400246;8642.178992995656;8518.87221691675;8564.700235491759;8567.357448191411;8608.698695545625;8617.396782225247;8492.938382702163;8591.742247732516;8602.655893764304;8608.354373421957;8620.698275560326;35748.28503429943;35960.82019589911;36034.27931441383;36093.45859812105;36179;2863.1983044747503;3349.9280230326303;3423.623401425841;3438.7420943429343;3522.489239060322;26224.21327360182;28958.276043098882;28984.565231521545;29004.70995290041;29213.26966825825;4008.779517126557;4066.877993660195;4122.6083522065355;4125.773082480462;4125.793710314472;226768;227966;228064;228227;229459;56069.43930560724;56158.71920640452;56207.18964051781;56334.7183264081;56432.43567564354;59380.70309648424;59480.70259648674;59962.400375996556;60030.399696003355;60105.39894601086;15377.461788837338;16066.598335041484;16239.106849123174;16293.755593666105;16327.428540001043;11961;12015.759684806255;12017.33904635236;12042.518299267931;12046.096542759153;19450.902745486183;19658.901705491382;19831.504212394517;20445.2844150454;20474.488137796674;8001.279884810395;8052.516848989079;8119.782032695143;8252.793680158044;8268.131846156188;914.6615752171606;935.3592788939599;943.2972435535432;1067.2049323254225;1091.2961140064615;28758.403236361242;28853.85573072121;28930;29104.708952910623;29290.121296361143;1049.6693541534391;1100.4387762241315;1119.367557330106;1138.6527109231763;1139.4530625299737;14869.702605947821;15014.24928753558;15056.849431505763;15097.849021509644;15284.923575382052;312921;313154;314763;315593;317549;51650.48349516532;52106.47893521092;52182.47817521852;52319.95360092853;52467.73766131145;1273.9681507962375;1284.2487145020082;1333.5399287245884;1349.5411560069624;1351.5877657314613;27236.455270894076;28138.467537921686;28483.857580711963;28746.281342966595;28879.42241155207;46827.29759053549;46942.06115877732;47063.76468117638;47154.764226178646;47468.28797568108;252393;253942;254059;254229;254663;32208.516872247405;32224.355512889142;32236;32359.19102022374;32551.348973019933;42343.3648495279;43347.783261083496;43418.565814341455;44159.33760993652;44504;36561.45157822582;37493.81253093717;37919.62080379271;37957.62042379541;38141.237175256894;36277.455838162976;36801;37567.6243237575;39440.40839387469;39441.802790985865;33538.66461335453;33625;37926;38704;38848.64029759058;28094;30663.919254007647;32610;32726.34547309088;33064.66935330616;25237.11670091538;25420.364490887874;25549.489010220062;25569.553202440562;25649.743502564736 22:19:02 INFO - PROCESS | 19378 | |2;jquery.html;331.79097168783665;339.54500968701933;341.45878782130325;347.87824261508473;353.6375215404209;15908.443204487845;16285.75571366429;16920.915395423035;17008;17035.488935331945;16278.674426511463;16618.83381166188;16911;17309.653806923885;17324.393646222386;2946.823190608565;5388.218708287296;5550.417206193352;5585.664860108386;5599.188117722948;5454.372747134071;5471.097268950618;5474.479924407175;5521.503064724174;5551.528120109775;5288.788448462057;5405.243265942771;5421;5474.835754927359;5484.945150548503;5381.4349493303225;5429.4299098594865;5440.4287549807295;5445.482679145494;5473.726313684339;4846.297286893416;4851.757412129379;4856.125897338477;4856.975715121437;4883.487233840431;12248.877511224862;18487.537811554685;19366.515837104045;19379.80620193794;19413;2142.1859693316596;2153.181790919456;2232.441889527618;2786.317352248692;2802.3974845408334;9177.128172823572;9403.905960940372;9547.093026162504;9575.138237558584;9593.04069593042;1846.8522518198647;1886.9905650471796;1894.0719047666544;1925.4608709561346;2042.8570000099999;62029.68985155045;67334;67660.98508522425;68435.65782171107;69573.65213173901;9884.209263258923;10172.287939844287;10249.12882404989;10253.436061016715;10422.947885260524;13199.340032998503;13309.73380532384;13475.393607287695;13485.595432137052;13607.931960340333;7378.889316660255;7548.584827834412;7556.168821429638;7739.806504837424;7822.374210063182;7583.05211848519;7615.314621683964;7694.576798276148;7722.498037627536;7751.534907905544;4390.2317094508335;4392.38506609075;4433.534478879671;4503.482099558527;4503.7522936238165;1796.3353559183186;1806.530302121458;1822.7083666613278;1825.488863118329;1834.339637730416;866.9176428239307;871.4901782457333;899.8065415935474;933.8552524358736;939.7415710679481;16060.75908861368;16386.67226655484;16716.331346745996;16741.49775506737;17222.138893055548;907.4056492997097;921.8202450522218;923.1553128887127;928.865314529403;940.2571968145226;8999.460032397947;9486.193673537826;9717.757056073513;9724.513774311255;9765.121139097515;252314;255163;255863;256037;256187;77230;78662;78902;79847;80594.77620895216;985.6796541124163;1007.8840933292619;1035.917126629883;1042.11940909931;1042.4943902207424;14536.27318634043;14713.485028023968;14928.925355373154;14975.550733478012;15221.162836044125;33525.83237083799;34390;34655.82672086724;34901.301973960886;35011.82494087513;45200;49322.75338623284;49935.75032124816;49966.25050624171;50327.74836125796;8031.59842007909;8138.430309878252;8169.101398846004;8173.019237691515;8175.427720059776;11693.415329233674;12798.488060477477;12810.743785124432;12834.422450989914;12882.871171288167;5227.764750586309;10475.952404759462;10978.725531861768;10985.176111791488;11044.226904116957;10667.413292269;10696.83954740664;10990.450477476254;11129.721756956142;11179.776404472028;11131.72170695739;11234.382108984084;11241.213115081866;11274.492647830702;11397.658070257905;7564.886526701994;7696.576688281974;7774.105977812624;7784.649690764042;7899.486533375312;9681.273904457054;9775.462349570558;9906.900930990598;10027.398356098658;10070.647527336509 22:19:02 INFO - PROCESS | 19378 | |3;mootools.html;1410.5274732964456;1415.5541004583558;1526.709925114229;1666.4833901490547;1689.5944973206426;7236.312550307719;7278.490505664606;7387.076615423072;7430.517016393931;7443.255674432561;7464.029676142108;7468.887966680504;7525.774226773206;7533.698652053925;7546.7358642447525;2180.4330873972763;2201.2955854126685;2210.2153735423935;2216.4791274050585;2225.9888700556476;2204.900779464928;2211.3587059752654;2234.5866014787234;2257.0633187227363;2258.0516183203094;2174.5324755177635;2193.287181665957;2195.4730864592543;2214.1475531920164;2216.2575537195057;2203.9449013774624;2219.0236296029775;2234.597772400967;2234.832387570939;2244.3154837774473;2231.0964059555904;2239.8880055997297;2245.292732789166;2245.65192395179;2248.4154119928935;7383.852322953565;7415.258474152595;7453.925460745378;7476.813079673052;7495.1005879294835;4514.7291162530355;4606.401167848158;4610.170169369512;4613.400257966443;4618.930716039228;2850.1876965065067;3027.606411166534;3035.8937437189593;3062.9540556891666;3072.38552289543;934.9859752103724;963.7060696487639;978.8140253351911;986.6398764450995;1008.2337423558075;10033.749156271078;10081.19350451962;10102.34334768245;10107.444090574942;10149.086582207638;3867.1298957734284;3898.8830335089992;3900.258950799339;3929.057026313664;3956.723029387973;8087.393445491494;8128.431009829374;8145.104038555754;8155.143709910374;8170;4428.645708343325;4435.711678740871;4440.200763862471;4488.4165058542185;4505.526919673387;3711.6473934976134;4140.047789008485;4145.585441455831;4148.191102734998;4193.517745459311;3346.0798280472577;3362.2434952136064;3383.2218589724503;3387.627360990289;3412.436947903568;982.0523195116747;1009.7021378693303;1013.1438934100673;1017.4149863828328;1020.3928662445833;976.6142373762324;1209.9274043557414;1268.949242030327;1281.4272516862163;1308.7055412532295;7074.3633073023675;7080.858382832314;7133.857322853618;7164.749233776793;7172.928270717331;461.05943874496324;466.29822117713303;475.19217330538225;486.8028448478372;488.83135318315124;5425.945740542623;5437.32033495813;5442.156465747816;5491.313585801775;5508.724563771795;8572.357073219533;8966.955165224263;9018.86471702925;9061.68284110066;9086.81826363469;8938.240249578728;8960.910390896139;8961;8962.058983806737;9006.774830629287;6872.587644741331;6989.860202796017;7015.543989640657;7017.122859642544;7119.1457025157315;7079.469039821931;7123.394511466376;7124.821879453055;7126.714931402893;7142.285771422816;7827.178146294557;8002.359811215205;8093.028836539653;8187;8214.917850821415;8250.54621995796;8259.876101858357;8325.833483330178;8339.749807505785;8365;6479.935200647933;6488.643124628191;6602.867942641216;6839.93160068393;6871.587704737732;7083.043789088407;7144.571325720473;7153.82115447118;7161.248068952685;7202.243764404662;6410.391012853772;6523.086767852409;6585.078089067631;6604.3725846044545;6614.768483103068;6334.303226645157;6337.683115844282;6350.7142178603;6404.327545607644;6428.4857211423905;6630.436412904957;6639.4688424924925;6700.564463309869;6745.831354216184;6759.763408280686;6113.908291375722;6227.782027629011;6244.938360478639;6245;6264.248290205204;6398.456131228898;6404.647744374104;6435.774747883802;6444.806655800334;6497.772577959749 22:19:02 INFO - PROCESS | 19378 | |4;prototype.html;318.75615154406876;320.4760217045131;323.4323761798046;327.99180020499483;329.61270507154086;6295.937040629598;6364.554481186313;6375.776847810327;6383.361663833614;6396.200474940632;6234.594751341159;6235.220597425322;6240.282367527736;6255.343188965161;6264.279607845099;4604.608608268301;4668.5098064703225;4695.506971767966;4711.623070154379;4745.50172231915;4678.7426691531955;4688.789004494789;4695.272232803921;4706.552877476634;4711.787969541362;4602.539746025387;4657.6273898088075;4697.9060418791605;4699.177643912319;4699.365585645928;4663.207254766698;4691.554302341272;4691.6715829891755;4716.858494245178;4728.243481043051;4026.798660067014;4043.65628921542;4049.392591111357;4051.210014047262;4057.1682805025193;5987.580869339148;5992.161097446361;5993.61041532299;5995.340512543617;6005.669688167149;5268.683878967274;5441.809536666237;5449.863753406157;5454.809081682161;5457.481539253765;6554.082428460019;6597.63712995785;6606.570572912793;6627.668616569153;6645.235797883257;4442.733435993819;4454.8886277842985;4456.598906098434;4462.1968045751755;4463.352813842007;6898.103246577913;6924.549904256258;6960.825979350557;6966.721331146748;6971.128608923885;4561.452625684939;4562.270036794097;4563.657725670588;4565.589096981221;4568.109218702321;4436.7559784211535;4549.886252843639;4550.681452298373;4553.954460455419;4556.589906908394;5351.892962140735;5358.758855851496;5395.136778115482;5413.296271484682;5434.212039254286;6700.765473208415;6700.966495167493;6713.731450741916;6734.8989765153565;6808.183018037867;1609.3240838847712;1638.0990455249803;1638.5330180898386;1638.7623794549725;1640.3192675039963;1023.3041531758327;1042.9113525350278;1061.1404762142688;1065.1372388365448;1070.1011150633506;6267.811965641038;6270.874582508415;6280.654563999024;6305.4009869062365;6305.621662700252;6844.5208835381045;6893.93106068943;6898.793036208922;6913.89629155563;6924.549904256207;6210.4100110489435;6300.117983482316;6375.4262116409745;6397.360263973658;6418.454431373292;3723.646253605903;3743.082944678571;3744.251149770057;3747.4940882980995;3786.3941769316775;7249.710011599583;7283.198848126702;7296.635168241567;7301.233370496021;7307.671154798047;7067.010618513412;7106.395956343666;7112.466565007645;7114;7121.92878071223;6952.721891124298;7101.289871012961;7129.429645628337;7149.499535032602;7308.598027108454;6906.274841141608;6936.930630693831;6938.202106757585;6939.167299924042;6944.479164062816;6811.284815094344;6811.8978215325815;6854.725810967506;6876.518643694893;6880;7255.709771609077;7262.273772622695;7274.854502910018;7286.453515986428;7295.635218239173;4528.750918699503;4586.403767510203;4633.073385323017;4643.349931009729;4660.557247061523;6946.479014073863;6949.930500695131;6961.930380696128;7001.299870012958;7011.8247043822275;6687.665616719242;6724.529282950342;6728.091707619409;6729.730810767514;6734.831629209309;6672.399484046459;6733.562318449285;6733.966330168318;6748.460123190035;6763.391294783493;6400.487960963205;6616.867662646624;6618.702158402787;6639.767608133692;6669.0663307136065;6743.718693448229;6762.42519385838;6789.966050169717;6795.592264464148;6803.591784492946;6679.799606011828;6685.231198412245;6690.59856408617;6695.263521012782;6714.764983225564 22:19:02 INFO - PROCESS | 19378 | |5;yui.html;726.5168662839212;765.6695156695156;794.3287921706157;814.1736137820112;820.7250571058695;14114.858851411484;14233.928830355833;14337.498187563411;14347.497837575687;14376.640583985392;13364.398602062905;13364.465421383158;13388.799168012487;13393.464261429555;13424;756.1606616655508;768.9538627682329;771.2210667226115;780.2041917244408;783.2519943454016;795.1491903663083;795.1889073145388;798.9720359787409;799.5682331540961;800.5076877720219;823.0945959444623;824.8432797768405;834.7579202031403;835.3734698975768;836.7698882807216;814.6578437056451;819.3117781063905;820.122468958215;822.8230930349973;823.9011318641741;605.5972778102556;609.1502354215888;610.5359926455881;611.3733423241168;612.4916319454886;14158.221297828615;14194.645133871632;14234.359453824603;14237.857621423756;14254.3585538651;12467.251964882045;12723.172993755376;12836.1014728969;12994.675133121653;13252.801207981887;9987.450690212036;10060.547275372626;10206.489675516195;11040.061594764455;11061.612843550518;3611.9277614447565;3645.1616128290375;3647.1793846384617;3655.9268814623824;3732.682721968636;51803;52017.47982520164;52069;52457.2131418029;53229.999999999614;10059;10096.293259471913;10127.189824813997;10243.692689219186;10361.792764144675;18002.459926202235;18085.27658893656;18088.27646894136;18119.275228990955;18131.456056318333;7202.171750248684;7229.7469588564145;7336.926630733731;7603.923960760321;7791.883121753178;4303.139372125587;4308.892277693083;4327.0480494291205;4464.6428285737065;4502.594766471033;2953.852307384665;2996.745276651509;3006.1582756828125;3008.2178633554995;3008.413359394941;536.1796451429319;540.5837505121035;545.9481349271813;546.5354448718557;547.4908335248257;538.5153361974254;559.0329918672543;584.8917950179231;670.8658268346351;672.7342699633617;8230.547319897463;8260.297874680598;8262.669493220325;8434.325253979667;8446.535440550706;535.764263723968;558.804418453538;589.9203607512931;603.8822429626268;644.0468107201275;3693.6306369362846;3824;3860.3630400984084;3875.1668391296007;3893.5133108361456;47250.5274947253;47364;47553.04893902103;47721;58842.70578647165;52120.478795211566;53654.46345536573;53963.730181348845;54104.72947635237;54266.45733542614;47120.528794711616;47149.292760608616;47169;47336;47515;7675.385969122345;7820.726274580363;7974.122846486998;7979.9601001994615;8058.234467725557;32588;33065.66934330626;33262.833685831414;34185;34291.314173716884;42163.578364217195;42192.1561568773;45808.770956145;45971;46964.295535567675;9620.855687164838;9753.60985560598;9921.107100361001;10485.633002844865;10623.150147988297;11752.11859110553;11894.643160705193;12085.879141208476;12411.503539858666;12427.067969902113;10830.51262693165;11011.504482298476;11034.613788517363;11037.613683521038;11460.713482162679;11062.944685276521;11161.107111430903;11221.495032723384;11241.269317494336;11495.54017839277;10268.845967310346;10428.322159059637;10971.122310215324;11007.779844403227;11391.088712903114;9474.857877131986;9574.617015319309;9628.75928101803;9829.803403932025;9949.353292035994;9619.89816214506;9683.66107186245;9705.805883882424;9730.75673108178;9735.805283894424 22:19:02 INFO - PROCESS | 19378 | __end_tp_report 22:19:02 INFO - PROCESS | 19378 | __start_cc_report 22:19:02 INFO - PROCESS | 19378 | _x_x_mozilla_cycle_collect,305 22:19:02 INFO - PROCESS | 19378 | __end_cc_report 22:19:02 INFO - PROCESS | 19378 | __startTimestamp1456899542879__endTimestamp 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | ------- Summary: start ------- 22:19:02 INFO - PROCESS | 19378 | Number of tests: 6 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#0] dojo.html Cycles:165 Average:5252.82 Median:5445.26 stddev:584.36 (10.7%) stddev-sans-first:561.57 22:19:02 INFO - PROCESS | 19378 | Values: 3115.1 3140.7 3159.4 3166.4 3191.2 5116.1 5196.6 5236.7 5242.1 5321.2 5275.3 5275.8 5341.2 5344.7 5352.3 4800.7 4813.8 4823.5 4916.2 4988.2 4971.5 4973.7 5006.8 5011.2 5031.6 4662.8 4675.2 4693.0 4705.5 4729.8 4741.0 4761.3 4776.0 4808.0 4809.6 4635.1 4711.3 4758.8 4760.6 4798.5 5078.8 5113.8 5126.3 5138.0 5167.1 5645.6 5646.5 5653.0 5656.4 5703.2 5639.3 5681.2 5692.2 5709.7 5768.3 5368.7 5393.6 5401.6 5403.3 5407.5 5830.7 5834.3 5834.6 5854.7 5859.4 5496.0 5517.0 5528.3 5572.7 5610.6 5675.4 5676.1 5677.3 5694.0 5701.2 5531.6 5578.4 5666.5 5666.7 5718.9 5461.5 5512.7 5530.8 5561.7 5642.8 4361.3 4368.2 4371.3 4393.2 4402.9 3878.1 3885.3 3895.5 3896.9 3916.1 5249.5 5273.6 5293.8 5315.8 5329.5 5673.3 5711.4 5728.7 5729.8 5743.1 5335.9 5346.7 5348.4 5351.8 5364.2 4671.4 4782.5 4821.7 4831.4 4853.1 5836.2 5837.1 5846.4 5851.3 5856.0 5518.5 5558.2 5558.3 5574.7 5587.9 5641.3 5756.1 5797.3 5847.4 5893.6 5611.5 5633.3 5633.7 5643.4 5647.3 5559.8 5773.1 5783.8 5784.3 5785.5 5445.3 5480.3 5482.2 5545.1 5574.7 5476.7 5522.9 5544.9 5573.9 5642.4 5393.0 5398.8 5402.9 5403.0 5415.6 5494.2 5516.7 5584.9 5585.4 5622.1 5415.9 5440.8 5446.1 5450.3 5450.5 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#1] ext.html Cycles:180 Average:43751.91 Median:35928.64 stddev:69890.93 (194.5%) stddev-sans-first:70011.60 22:19:02 INFO - PROCESS | 19378 | Values: 516.8 520.7 535.7 547.1 595.5 34272.8 34616.5 34658.7 34905.8 34965.8 35896.5 36062.5 36274.6 36503.0 36517.3 8345.9 8611.4 8665.2 8667.9 8672.0 8419.7 8545.4 8555.8 8566.3 8610.8 8565.3 8570.8 8601.4 8615.4 8642.2 8518.9 8564.7 8567.4 8608.7 8617.4 8492.9 8591.7 8602.7 8608.4 8620.7 35748.3 35960.8 36034.3 36093.5 36179.0 2863.2 3349.9 3423.6 3438.7 3522.5 26224.2 28958.3 28984.6 29004.7 29213.3 4008.8 4066.9 4122.6 4125.8 4125.8 226768.0 227966.0 228064.0 228227.0 229459.0 56069.4 56158.7 56207.2 56334.7 56432.4 59380.7 59480.7 59962.4 60030.4 60105.4 15377.5 16066.6 16239.1 16293.8 16327.4 11961.0 12015.8 12017.3 12042.5 12046.1 19450.9 19658.9 19831.5 20445.3 20474.5 8001.3 8052.5 8119.8 8252.8 8268.1 914.7 935.4 943.3 1067.2 1091.3 28758.4 28853.9 28930.0 29104.7 29290.1 1049.7 1100.4 1119.4 1138.7 1139.5 14869.7 15014.2 15056.8 15097.8 15284.9 312921.0 313154.0 314763.0 315593.0 317549.0 51650.5 52106.5 52182.5 52320.0 52467.7 1274.0 1284.2 1333.5 1349.5 1351.6 27236.5 28138.5 28483.9 28746.3 28879.4 46827.3 46942.1 47063.8 47154.8 47468.3 252393.0 253942.0 254059.0 254229.0 254663.0 32208.5 32224.4 32236.0 32359.2 32551.3 42343.4 43347.8 43418.6 44159.3 44504.0 36561.5 37493.8 37919.6 37957.6 38141.2 36277.5 36801.0 37567.6 39440.4 39441.8 33538.7 33625.0 37926.0 38704.0 38848.6 28094.0 30663.9 32610.0 32726.3 33064.7 25237.1 25420.4 25549.5 25569.6 25649.7 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#2] jquery.html Cycles:180 Average:20434.13 Median:4391.31 stddev:43344.29 (987.0%) stddev-sans-first:43439.61 22:19:02 INFO - PROCESS | 19378 | Values: 331.8 339.5 341.5 347.9 353.6 15908.4 16285.8 16920.9 17008.0 17035.5 16278.7 16618.8 16911.0 17309.7 17324.4 2946.8 5388.2 5550.4 5585.7 5599.2 5454.4 5471.1 5474.5 5521.5 5551.5 5288.8 5405.2 5421.0 5474.8 5484.9 5381.4 5429.4 5440.4 5445.5 5473.7 4846.3 4851.8 4856.1 4857.0 4883.5 12248.9 18487.5 19366.5 19379.8 19413.0 2142.2 2153.2 2232.4 2786.3 2802.4 9177.1 9403.9 9547.1 9575.1 9593.0 1846.9 1887.0 1894.1 1925.5 2042.9 62029.7 67334.0 67661.0 68435.7 69573.7 9884.2 10172.3 10249.1 10253.4 10422.9 13199.3 13309.7 13475.4 13485.6 13607.9 7378.9 7548.6 7556.2 7739.8 7822.4 7583.1 7615.3 7694.6 7722.5 7751.5 4390.2 4392.4 4433.5 4503.5 4503.8 1796.3 1806.5 1822.7 1825.5 1834.3 866.9 871.5 899.8 933.9 939.7 16060.8 16386.7 16716.3 16741.5 17222.1 907.4 921.8 923.2 928.9 940.3 8999.5 9486.2 9717.8 9724.5 9765.1 252314.0 255163.0 255863.0 256037.0 256187.0 77230.0 78662.0 78902.0 79847.0 80594.8 985.7 1007.9 1035.9 1042.1 1042.5 14536.3 14713.5 14928.9 14975.6 15221.2 33525.8 34390.0 34655.8 34901.3 35011.8 45200.0 49322.8 49935.8 49966.3 50327.7 8031.6 8138.4 8169.1 8173.0 8175.4 11693.4 12798.5 12810.7 12834.4 12882.9 5227.8 10476.0 10978.7 10985.2 11044.2 10667.4 10696.8 10990.5 11129.7 11179.8 11131.7 11234.4 11241.2 11274.5 11397.7 7564.9 7696.6 7774.1 7784.6 7899.5 9681.3 9775.5 9906.9 10027.4 10070.6 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#3] mootools.html Cycles:180 Average:5203.90 Median:6344.20 stddev:2704.46 (42.6%) stddev-sans-first:2697.01 22:19:02 INFO - PROCESS | 19378 | Values: 1410.5 1415.6 1526.7 1666.5 1689.6 7236.3 7278.5 7387.1 7430.5 7443.3 7464.0 7468.9 7525.8 7533.7 7546.7 2180.4 2201.3 2210.2 2216.5 2226.0 2204.9 2211.4 2234.6 2257.1 2258.1 2174.5 2193.3 2195.5 2214.1 2216.3 2203.9 2219.0 2234.6 2234.8 2244.3 2231.1 2239.9 2245.3 2245.7 2248.4 7383.9 7415.3 7453.9 7476.8 7495.1 4514.7 4606.4 4610.2 4613.4 4618.9 2850.2 3027.6 3035.9 3063.0 3072.4 935.0 963.7 978.8 986.6 1008.2 10033.7 10081.2 10102.3 10107.4 10149.1 3867.1 3898.9 3900.3 3929.1 3956.7 8087.4 8128.4 8145.1 8155.1 8170.0 4428.6 4435.7 4440.2 4488.4 4505.5 3711.6 4140.0 4145.6 4148.2 4193.5 3346.1 3362.2 3383.2 3387.6 3412.4 982.1 1009.7 1013.1 1017.4 1020.4 976.6 1209.9 1268.9 1281.4 1308.7 7074.4 7080.9 7133.9 7164.7 7172.9 461.1 466.3 475.2 486.8 488.8 5425.9 5437.3 5442.2 5491.3 5508.7 8572.4 8967.0 9018.9 9061.7 9086.8 8938.2 8960.9 8961.0 8962.1 9006.8 6872.6 6989.9 7015.5 7017.1 7119.1 7079.5 7123.4 7124.8 7126.7 7142.3 7827.2 8002.4 8093.0 8187.0 8214.9 8250.5 8259.9 8325.8 8339.7 8365.0 6479.9 6488.6 6602.9 6839.9 6871.6 7083.0 7144.6 7153.8 7161.2 7202.2 6410.4 6523.1 6585.1 6604.4 6614.8 6334.3 6337.7 6350.7 6404.3 6428.5 6630.4 6639.5 6700.6 6745.8 6759.8 6113.9 6227.8 6244.9 6245.0 6264.2 6398.5 6404.6 6435.8 6444.8 6497.8 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#4] prototype.html Cycles:180 Average:5555.29 Median:6302.76 stddev:1732.97 (27.5%) stddev-sans-first:1692.67 22:19:02 INFO - PROCESS | 19378 | Values: 318.8 320.5 323.4 328.0 329.6 6295.9 6364.6 6375.8 6383.4 6396.2 6234.6 6235.2 6240.3 6255.3 6264.3 4604.6 4668.5 4695.5 4711.6 4745.5 4678.7 4688.8 4695.3 4706.6 4711.8 4602.5 4657.6 4697.9 4699.2 4699.4 4663.2 4691.6 4691.7 4716.9 4728.2 4026.8 4043.7 4049.4 4051.2 4057.2 5987.6 5992.2 5993.6 5995.3 6005.7 5268.7 5441.8 5449.9 5454.8 5457.5 6554.1 6597.6 6606.6 6627.7 6645.2 4442.7 4454.9 4456.6 4462.2 4463.4 6898.1 6924.5 6960.8 6966.7 6971.1 4561.5 4562.3 4563.7 4565.6 4568.1 4436.8 4549.9 4550.7 4554.0 4556.6 5351.9 5358.8 5395.1 5413.3 5434.2 6700.8 6701.0 6713.7 6734.9 6808.2 1609.3 1638.1 1638.5 1638.8 1640.3 1023.3 1042.9 1061.1 1065.1 1070.1 6267.8 6270.9 6280.7 6305.4 6305.6 6844.5 6893.9 6898.8 6913.9 6924.5 6210.4 6300.1 6375.4 6397.4 6418.5 3723.6 3743.1 3744.3 3747.5 3786.4 7249.7 7283.2 7296.6 7301.2 7307.7 7067.0 7106.4 7112.5 7114.0 7121.9 6952.7 7101.3 7129.4 7149.5 7308.6 6906.3 6936.9 6938.2 6939.2 6944.5 6811.3 6811.9 6854.7 6876.5 6880.0 7255.7 7262.3 7274.9 7286.5 7295.6 4528.8 4586.4 4633.1 4643.3 4660.6 6946.5 6949.9 6961.9 7001.3 7011.8 6687.7 6724.5 6728.1 6729.7 6734.8 6672.4 6733.6 6734.0 6748.5 6763.4 6400.5 6616.9 6618.7 6639.8 6669.1 6743.7 6762.4 6790.0 6795.6 6803.6 6679.8 6685.2 6690.6 6695.3 6714.8 22:19:02 INFO - PROCESS | 19378 | 22:19:02 INFO - PROCESS | 19378 | [#5] yui.html Cycles:180 Average:13724.89 Median:47350.00 stddev:15871.73 (33.5%) stddev-sans-first:15886.23 22:19:02 INFO - PROCESS | 19378 | Values: 726.5 765.7 794.3 814.2 820.7 14114.9 14233.9 14337.5 14347.5 14376.6 13364.4 13364.5 13388.8 13393.5 13424.0 756.2 769.0 771.2 780.2 783.3 795.1 795.2 799.0 799.6 800.5 823.1 824.8 834.8 835.4 836.8 814.7 819.3 820.1 822.8 823.9 605.6 609.2 610.5 611.4 612.5 14158.2 14194.6 14234.4 14237.9 14254.4 12467.3 12723.2 12836.1 12994.7 13252.8 9987.5 10060.5 10206.5 11040.1 11061.6 3611.9 3645.2 3647.2 3655.9 3732.7 51803.0 52017.5 52069.0 52457.2 53230.0 10059.0 10096.3 10127.2 10243.7 10361.8 18002.5 18085.3 18088.3 18119.3 18131.5 7202.2 7229.7 7336.9 7603.9 7791.9 4303.1 4308.9 4327.0 4464.6 4502.6 2953.9 2996.7 3006.2 3008.2 3008.4 536.2 540.6 545.9 546.5 547.5 538.5 559.0 584.9 670.9 672.7 8230.5 8260.3 8262.7 8434.3 8446.5 535.8 558.8 589.9 603.9 644.0 3693.6 3824.0 3860.4 3875.2 3893.5 47250.5 47364.0 47553.0 47721.0 58842.7 52120.5 53654.5 53963.7 54104.7 54266.5 47120.5 47149.3 47169.0 47336.0 47515.0 7675.4 7820.7 7974.1 7980.0 8058.2 32588.0 33065.7 33262.8 34185.0 34291.3 42163.6 42192.2 45808.8 45971.0 46964.3 9620.9 9753.6 9921.1 10485.6 10623.2 11752.1 11894.6 12085.9 12411.5 12427.1 10830.5 11011.5 11034.6 11037.6 11460.7 11062.9 11161.1 11221.5 11241.3 11495.5 10268.8 10428.3 10971.1 11007.8 11391.1 9474.9 9574.6 9628.8 9829.8 9949.4 9619.9 9683.7 9705.8 9730.8 9735.8 22:19:02 INFO - PROCESS | 19378 | -------- Summary: end -------- 22:19:02 INFO - PROCESS | 19378 | 22:19:03 INFO - TEST-INFO | 19378: exit 0 22:19:03 INFO - TEST-OK | dromaeo_css | took 1111058ms 22:19:03 INFO - TEST-START | kraken 22:19:03 INFO - operating with platform_type : linux_ 22:19:03 INFO - Initialising browser for kraken test... 22:19:03 INFO - TEST-INFO | started process 19616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprBQxnx/profile http://localhost:48169/getInfo.html) 22:19:07 INFO - PROCESS | 19616 | 22:19:07 INFO - PROCESS | 19616 | (process:19686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:08 INFO - PROCESS | 19616 | __metrics Screen width/height:1600/1200 22:19:08 INFO - PROCESS | 19616 | colorDepth:24 22:19:08 INFO - PROCESS | 19616 | Browser inner width/height: 1024/697 22:19:08 INFO - PROCESS | 19616 | __metrics 22:19:08 ERROR - PROCESS | 19616 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:19:09 INFO - TEST-INFO | 19616: exit 0 22:19:09 INFO - Browser initialized. 22:19:09 INFO - Running cycle 1/1 for kraken test... 22:19:09 INFO - TEST-INFO | started process 19737 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprBQxnx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:10 INFO - PROCESS | 19737 | 22:19:10 INFO - PROCESS | 19737 | (process:19797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:21 INFO - PROCESS | 19737 | RSS: Main: 161439744 22:19:21 INFO - PROCESS | 19737 | 22:19:23 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48169/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:24 INFO - PROCESS | 19737 | RSS: Main: 168148992 22:19:24 INFO - PROCESS | 19737 | 22:19:27 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48169/tests/kraken/driver.html?testName=audio-dft) 22:19:27 INFO - PROCESS | 19737 | RSS: Main: 170446848 22:19:27 INFO - PROCESS | 19737 | 22:19:30 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48169/tests/kraken/driver.html?testName=audio-fft) 22:19:31 INFO - PROCESS | 19737 | RSS: Main: 165548032 22:19:31 INFO - PROCESS | 19737 | 22:19:33 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48169/tests/kraken/driver.html?testName=audio-oscillator) 22:19:33 INFO - PROCESS | 19737 | RSS: Main: 165289984 22:19:33 INFO - PROCESS | 19737 | 22:19:36 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:36 INFO - PROCESS | 19737 | RSS: Main: 165908480 22:19:36 INFO - PROCESS | 19737 | 22:19:39 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48169/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:40 INFO - PROCESS | 19737 | RSS: Main: 166133760 22:19:40 INFO - PROCESS | 19737 | 22:19:43 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48169/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:44 INFO - PROCESS | 19737 | RSS: Main: 165949440 22:19:44 INFO - PROCESS | 19737 | 22:19:47 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48169/tests/kraken/driver.html?testName=json-parse-financial) 22:19:47 INFO - PROCESS | 19737 | RSS: Main: 166727680 22:19:47 INFO - PROCESS | 19737 | 22:19:49 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:49 INFO - PROCESS | 19737 | RSS: Main: 166649856 22:19:49 INFO - PROCESS | 19737 | 22:19:51 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:52 INFO - PROCESS | 19737 | RSS: Main: 165085184 22:19:52 INFO - PROCESS | 19737 | 22:19:54 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:54 INFO - PROCESS | 19737 | RSS: Main: 166936576 22:19:54 INFO - PROCESS | 19737 | 22:19:57 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:57 INFO - PROCESS | 19737 | RSS: Main: 167395328 22:19:57 INFO - PROCESS | 19737 | 22:20:00 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:01 INFO - PROCESS | 19737 | RSS: Main: 167034880 22:20:01 INFO - PROCESS | 19737 | 22:20:02 INFO - PROCESS | 19737 | Cycle 1(1): loaded http://localhost:48169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48169/tests/kraken/driver.html?testName=ai-astar) 22:20:03 INFO - PROCESS | 19737 | RSS: Main: 167694336 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | __start_tp_report 22:20:03 INFO - PROCESS | 19737 | _x_x_mozilla_page_load 22:20:03 INFO - PROCESS | 19737 | _x_x_mozilla_page_load_details 22:20:03 INFO - PROCESS | 19737 | |i|pagename|runs| 22:20:03 INFO - PROCESS | 19737 | |0;ai-astar;112;106;113;111;113;124;110;111;112;111 22:20:03 INFO - PROCESS | 19737 | |1;audio-beat-detection;150;129;149;176;127;165;152;136;176;130 22:20:03 INFO - PROCESS | 19737 | |2;audio-dft;163;164;165;162;161;161;162;166;169;162 22:20:03 INFO - PROCESS | 19737 | |3;audio-fft;76;75;74;74;73;77;75;159;75;72 22:20:03 INFO - PROCESS | 19737 | |4;audio-oscillator;93;95;139;94;94;93;145;93;93;138 22:20:03 INFO - PROCESS | 19737 | |5;imaging-gaussian-blur;119;117;117;118;118;117;117;118;118;117 22:20:03 INFO - PROCESS | 19737 | |6;imaging-darkroom;147;146;147;147;147;146;146;147;149;146 22:20:03 INFO - PROCESS | 19737 | |7;imaging-desaturate;96;97;97;96;97;96;96;97;97;96 22:20:03 INFO - PROCESS | 19737 | |8;json-parse-financial;58;58;59;57;58;58;56;61;58;56 22:20:03 INFO - PROCESS | 19737 | |9;json-stringify-tinderbox;68;67;67;67;68;69;68;67;68;67 22:20:03 INFO - PROCESS | 19737 | |10;stanford-crypto-aes;81;84;84;83;83;84;84;82;82;81 22:20:03 INFO - PROCESS | 19737 | |11;stanford-crypto-ccm;117;113;120;126;118;127;126;118;120;124 22:20:03 INFO - PROCESS | 19737 | |12;stanford-crypto-pbkdf2;141;143;151;153;148;141;144;149;150;140 22:20:03 INFO - PROCESS | 19737 | |13;stanford-crypto-sha256-iterative;71;71;71;74;72;73;77;69;67;70 22:20:03 INFO - PROCESS | 19737 | __end_tp_report 22:20:03 INFO - PROCESS | 19737 | __start_cc_report 22:20:03 INFO - PROCESS | 19737 | _x_x_mozilla_cycle_collect,769 22:20:03 INFO - PROCESS | 19737 | __end_cc_report 22:20:03 INFO - PROCESS | 19737 | __startTimestamp1456899603049__endTimestamp 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | ------- Summary: start ------- 22:20:03 INFO - PROCESS | 19737 | Number of tests: 14 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.57 (4.1%) stddev-sans-first:4.85 22:20:03 INFO - PROCESS | 19737 | Values: 112.0 106.0 113.0 111.0 113.0 124.0 110.0 111.0 112.0 111.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:151.00 stddev:18.67 (12.4%) stddev-sans-first:19.80 22:20:03 INFO - PROCESS | 19737 | Values: 150.0 129.0 149.0 176.0 127.0 165.0 152.0 136.0 176.0 130.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.55 (1.6%) stddev-sans-first:2.70 22:20:03 INFO - PROCESS | 19737 | Values: 163.0 164.0 165.0 162.0 161.0 161.0 162.0 166.0 169.0 162.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:26.74 (35.7%) stddev-sans-first:28.24 22:20:03 INFO - PROCESS | 19737 | Values: 76.0 75.0 74.0 74.0 73.0 77.0 75.0 159.0 75.0 72.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:22.83 (24.5%) stddev-sans-first:23.58 22:20:03 INFO - PROCESS | 19737 | Values: 93.0 95.0 139.0 94.0 94.0 93.0 145.0 93.0 93.0 138.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 22:20:03 INFO - PROCESS | 19737 | Values: 119.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:20:03 INFO - PROCESS | 19737 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 149.0 146.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:20:03 INFO - PROCESS | 19737 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 96.0 97.0 97.0 96.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.45 (2.5%) stddev-sans-first:1.54 22:20:03 INFO - PROCESS | 19737 | Values: 58.0 58.0 59.0 57.0 58.0 58.0 56.0 61.0 58.0 56.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 22:20:03 INFO - PROCESS | 19737 | Values: 68.0 67.0 67.0 67.0 68.0 69.0 68.0 67.0 68.0 67.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:1.23 (1.5%) stddev-sans-first:1.12 22:20:03 INFO - PROCESS | 19737 | Values: 81.0 84.0 84.0 83.0 83.0 84.0 84.0 82.0 82.0 81.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:122.00 stddev:4.65 (3.8%) stddev-sans-first:4.72 22:20:03 INFO - PROCESS | 19737 | Values: 117.0 113.0 120.0 126.0 118.0 127.0 126.0 118.0 120.0 124.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.50 stddev:4.74 (3.2%) stddev-sans-first:4.67 22:20:03 INFO - PROCESS | 19737 | Values: 141.0 143.0 151.0 153.0 148.0 141.0 144.0 149.0 150.0 140.0 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - PROCESS | 19737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:2.76 (3.9%) stddev-sans-first:2.92 22:20:03 INFO - PROCESS | 19737 | Values: 71.0 71.0 71.0 74.0 72.0 73.0 77.0 69.0 67.0 70.0 22:20:03 INFO - PROCESS | 19737 | -------- Summary: end -------- 22:20:03 INFO - PROCESS | 19737 | 22:20:03 INFO - TEST-INFO | 19737: exit 0 22:20:04 INFO - TEST-OK | kraken | took 60512ms 22:20:04 INFO - SUITE-END | took 1171s 22:20:04 INFO - Completed test suite (00:19:31) 22:20:04 INFO - Working with test: dromaeo_css 22:20:04 INFO - Generating results file: dromaeo_css 22:20:04 INFO - Working with test: kraken 22:20:04 INFO - Generating results file: kraken 22:20:04 INFO - javascript benchmark 22:20:04 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:20:07 INFO - process_Request line: dromaeo_css 6827.49 graph.html#tests=[[72,63,43]] 22:20:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:20:07 INFO - process_Request line: kraken 1523.10 graph.html#tests=[[232,63,43]] 22:20:07 INFO - RETURN: dromaeo_css: 6827.49 22:20:07 INFO - RETURN: kraken: 1523.10 22:20:07 INFO - javascript benchmark 22:20:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3115.1277642260175, 3140.71733543981, 3159.4470967580683, 3166.445871972405, 3191.2021994501374, 5116.053530096935, 5196.610254230929, 5236.738163091844, 5242.135047717127, 5321.201819727043, 5275.261463395128, 5275.762590683419, 5341.1988201769755, 5344.652597581165, 5352.304200453946, 4800.735959522225, 4813.7593120343845, 4823.493533179018, 4916.1642520771375, 4988.176950803113, 4971.477994810547, 4973.726445045521, 5006.799728010875, 5011.2483127530795, 5031.647784655075, 4662.8134874604975, 4675.158471475133, 4692.97653511732, 4705.529447055302, 4729.787159577827, 4741.0, 4761.285807128924, 4776.0, 4807.975960120212, 4809.591184749301, 4635.072985402933, 4711.316859055452, 4758.762061896891, 4760.595349395306, 4798.47216806151, 5078.822241221539, 5113.795448182068, 5126.333576635051, 5138.0, 5167.147420675584, 5645.604807663465, 5646.520045796112, 5652.971735141339, 5656.4060773619, 5703.17303990919, 5639.295088113986, 5681.204631351614, 5692.17463467799, 5709.65742055478, 5768.307803063617, 5368.677879327252, 5393.622446428752, 5401.567874570064, 5403.297571315782, 5407.459254074561, 5830.679312637845, 5834.329052159056, 5834.5624078194305, 5854.707264636836, 5859.44335288147, 5496.0, 5516.972415137979, 5528.336599607992, 5572.721363931787, 5610.635308704921, 5675.3757086720425, 5676.063449530781, 5677.290338707661, 5693.9750844847495, 5701.173329867146, 5531.640443371168, 5578.442155784389, 5666.46168613981, 5666.688332141689, 5718.942810571841, 5461.453854614586, 5512.6968016759465, 5530.778768849201, 5561.749721262553, 5642.774289028393, 4361.345798130305, 4368.170047690928, 4371.344298355272, 4393.20922234001, 4402.9432936095745, 3878.127421330178, 3885.320068987916, 3895.49358583388, 3896.902577435587, 3916.099297161669, 5249.501297376743, 5273.604479664041, 5293.788248470018, 5315.760790764348, 5329.493698098674, 5673.290838645169, 5711.400302968129, 5728.656280623176, 5729.770809167587, 5743.10981797822, 5335.919961200585, 5346.652467589594, 5348.438413966555, 5351.839444816662, 5364.22218778275, 4671.43942726875, 4782.545658162469, 4821.686590371614, 4831.396075490564, 4853.126437241331, 5836.153757705109, 5837.066069428871, 5846.4153584642045, 5851.32709738377, 5855.970720146372, 5518.503334699896, 5558.194061861089, 5558.333000039859, 5574.749136288958, 5587.916181257366, 5641.294838145232, 5756.136579513107, 5797.333306669787, 5847.38602446737, 5893.616914900518, 5611.523020543136, 5633.267675202197, 5633.690147041788, 5643.3792282848035, 5647.29408823897, 5559.777608895599, 5773.1051686988585, 5783.826485205451, 5784.305883294031, 5785.508231800344, 5445.26488924006, 5480.314960629921, 5482.23248745168, 5545.112781954868, 5574.693391863324, 5476.72616369172, 5522.861928451821, 5544.861378465571, 5573.888522229451, 5642.435756424489, 5392.973035134799, 5398.838034858961, 5402.918956215739, 5402.972985135207, 5415.5938304626525, 5494.230807687007, 5516.724163791714, 5584.944150558605, 5585.441455854382, 5622.100463925753, 5415.864603384947, 5440.782368705366, 5446.074167391474, 5450.291462109901, 5450.454954504517], "unit": "score", "name": "dojo.html", "value": 5214.738481881708}, {"lowerIsBetter": false, "replicates": [516.8087807511221, 520.7292208051813, 535.7160704826441, 547.113675845131, 595.5325069820192, 34272.82863585685, 34616.480752788695, 34658.65341346589, 34905.825470872674, 34965.82517087417, 35896.46155307666, 36062.459063114075, 36274.63725362746, 36503.0, 36517.26965460696, 8345.873307103524, 8611.397202195849, 8665.220130188281, 8667.913320866774, 8672.0, 8419.747407577752, 8545.359098067638, 8555.786105347353, 8566.3146948244, 8610.784730381727, 8565.271951884097, 8570.828583428327, 8601.397902146853, 8615.439996400246, 8642.178992995656, 8518.87221691675, 8564.700235491759, 8567.357448191411, 8608.698695545625, 8617.396782225247, 8492.938382702163, 8591.742247732516, 8602.655893764304, 8608.354373421957, 8620.698275560326, 35748.28503429943, 35960.82019589911, 36034.27931441383, 36093.45859812105, 36179.0, 2863.1983044747503, 3349.9280230326303, 3423.623401425841, 3438.7420943429343, 3522.489239060322, 26224.21327360182, 28958.276043098882, 28984.565231521545, 29004.70995290041, 29213.26966825825, 4008.779517126557, 4066.877993660195, 4122.6083522065355, 4125.773082480462, 4125.793710314472, 226768.0, 227966.0, 228064.0, 228227.0, 229459.0, 56069.43930560724, 56158.71920640452, 56207.18964051781, 56334.7183264081, 56432.43567564354, 59380.70309648424, 59480.70259648674, 59962.400375996556, 60030.399696003355, 60105.39894601086, 15377.461788837338, 16066.598335041484, 16239.106849123174, 16293.755593666105, 16327.428540001043, 11961.0, 12015.759684806255, 12017.33904635236, 12042.518299267931, 12046.096542759153, 19450.902745486183, 19658.901705491382, 19831.504212394517, 20445.2844150454, 20474.488137796674, 8001.279884810395, 8052.516848989079, 8119.782032695143, 8252.793680158044, 8268.131846156188, 914.6615752171606, 935.3592788939599, 943.2972435535432, 1067.2049323254225, 1091.2961140064615, 28758.403236361242, 28853.85573072121, 28930.0, 29104.708952910623, 29290.121296361143, 1049.6693541534391, 1100.4387762241315, 1119.367557330106, 1138.6527109231763, 1139.4530625299737, 14869.702605947821, 15014.24928753558, 15056.849431505763, 15097.849021509644, 15284.923575382052, 312921.0, 313154.0, 314763.0, 315593.0, 317549.0, 51650.48349516532, 52106.47893521092, 52182.47817521852, 52319.95360092853, 52467.73766131145, 1273.9681507962375, 1284.2487145020082, 1333.5399287245884, 1349.5411560069624, 1351.5877657314613, 27236.455270894076, 28138.467537921686, 28483.857580711963, 28746.281342966595, 28879.42241155207, 46827.29759053549, 46942.06115877732, 47063.76468117638, 47154.764226178646, 47468.28797568108, 252393.0, 253942.0, 254059.0, 254229.0, 254663.0, 32208.516872247405, 32224.355512889142, 32236.0, 32359.19102022374, 32551.348973019933, 42343.3648495279, 43347.783261083496, 43418.565814341455, 44159.33760993652, 44504.0, 36561.45157822582, 37493.81253093717, 37919.62080379271, 37957.62042379541, 38141.237175256894, 36277.455838162976, 36801.0, 37567.6243237575, 39440.40839387469, 39441.802790985865, 33538.66461335453, 33625.0, 37926.0, 38704.0, 38848.64029759058, 28094.0, 30663.919254007647, 32610.0, 32726.34547309088, 33064.66935330616, 25237.11670091538, 25420.364490887874, 25549.489010220062, 25569.553202440562, 25649.743502564736], "unit": "score", "name": "ext.html", "value": 18176.974234997673}, {"lowerIsBetter": false, "replicates": [331.79097168783665, 339.54500968701933, 341.45878782130325, 347.87824261508473, 353.6375215404209, 15908.443204487845, 16285.75571366429, 16920.915395423035, 17008.0, 17035.488935331945, 16278.674426511463, 16618.83381166188, 16911.0, 17309.653806923885, 17324.393646222386, 2946.823190608565, 5388.218708287296, 5550.417206193352, 5585.664860108386, 5599.188117722948, 5454.372747134071, 5471.097268950618, 5474.479924407175, 5521.503064724174, 5551.528120109775, 5288.788448462057, 5405.243265942771, 5421.0, 5474.835754927359, 5484.945150548503, 5381.4349493303225, 5429.4299098594865, 5440.4287549807295, 5445.482679145494, 5473.726313684339, 4846.297286893416, 4851.757412129379, 4856.125897338477, 4856.975715121437, 4883.487233840431, 12248.877511224862, 18487.537811554685, 19366.515837104045, 19379.80620193794, 19413.0, 2142.1859693316596, 2153.181790919456, 2232.441889527618, 2786.317352248692, 2802.3974845408334, 9177.128172823572, 9403.905960940372, 9547.093026162504, 9575.138237558584, 9593.04069593042, 1846.8522518198647, 1886.9905650471796, 1894.0719047666544, 1925.4608709561346, 2042.8570000099999, 62029.68985155045, 67334.0, 67660.98508522425, 68435.65782171107, 69573.65213173901, 9884.209263258923, 10172.287939844287, 10249.12882404989, 10253.436061016715, 10422.947885260524, 13199.340032998503, 13309.73380532384, 13475.393607287695, 13485.595432137052, 13607.931960340333, 7378.889316660255, 7548.584827834412, 7556.168821429638, 7739.806504837424, 7822.374210063182, 7583.05211848519, 7615.314621683964, 7694.576798276148, 7722.498037627536, 7751.534907905544, 4390.2317094508335, 4392.38506609075, 4433.534478879671, 4503.482099558527, 4503.7522936238165, 1796.3353559183186, 1806.530302121458, 1822.7083666613278, 1825.488863118329, 1834.339637730416, 866.9176428239307, 871.4901782457333, 899.8065415935474, 933.8552524358736, 939.7415710679481, 16060.75908861368, 16386.67226655484, 16716.331346745996, 16741.49775506737, 17222.138893055548, 907.4056492997097, 921.8202450522218, 923.1553128887127, 928.865314529403, 940.2571968145226, 8999.460032397947, 9486.193673537826, 9717.757056073513, 9724.513774311255, 9765.121139097515, 252314.0, 255163.0, 255863.0, 256037.0, 256187.0, 77230.0, 78662.0, 78902.0, 79847.0, 80594.77620895216, 985.6796541124163, 1007.8840933292619, 1035.917126629883, 1042.11940909931, 1042.4943902207424, 14536.27318634043, 14713.485028023968, 14928.925355373154, 14975.550733478012, 15221.162836044125, 33525.83237083799, 34390.0, 34655.82672086724, 34901.301973960886, 35011.82494087513, 45200.0, 49322.75338623284, 49935.75032124816, 49966.25050624171, 50327.74836125796, 8031.59842007909, 8138.430309878252, 8169.101398846004, 8173.019237691515, 8175.427720059776, 11693.415329233674, 12798.488060477477, 12810.743785124432, 12834.422450989914, 12882.871171288167, 5227.764750586309, 10475.952404759462, 10978.725531861768, 10985.176111791488, 11044.226904116957, 10667.413292269, 10696.83954740664, 10990.450477476254, 11129.721756956142, 11179.776404472028, 11131.72170695739, 11234.382108984084, 11241.213115081866, 11274.492647830702, 11397.658070257905, 7564.886526701994, 7696.576688281974, 7774.105977812624, 7784.649690764042, 7899.486533375312, 9681.273904457054, 9775.462349570558, 9906.900930990598, 10027.398356098658, 10070.647527336509], "unit": "score", "name": "jquery.html", "value": 8212.2385357309}, {"lowerIsBetter": false, "replicates": [1410.5274732964456, 1415.5541004583558, 1526.709925114229, 1666.4833901490547, 1689.5944973206426, 7236.312550307719, 7278.490505664606, 7387.076615423072, 7430.517016393931, 7443.255674432561, 7464.029676142108, 7468.887966680504, 7525.774226773206, 7533.698652053925, 7546.7358642447525, 2180.4330873972763, 2201.2955854126685, 2210.2153735423935, 2216.4791274050585, 2225.9888700556476, 2204.900779464928, 2211.3587059752654, 2234.5866014787234, 2257.0633187227363, 2258.0516183203094, 2174.5324755177635, 2193.287181665957, 2195.4730864592543, 2214.1475531920164, 2216.2575537195057, 2203.9449013774624, 2219.0236296029775, 2234.597772400967, 2234.832387570939, 2244.3154837774473, 2231.0964059555904, 2239.8880055997297, 2245.292732789166, 2245.65192395179, 2248.4154119928935, 7383.852322953565, 7415.258474152595, 7453.925460745378, 7476.813079673052, 7495.1005879294835, 4514.7291162530355, 4606.401167848158, 4610.170169369512, 4613.400257966443, 4618.930716039228, 2850.1876965065067, 3027.606411166534, 3035.8937437189593, 3062.9540556891666, 3072.38552289543, 934.9859752103724, 963.7060696487639, 978.8140253351911, 986.6398764450995, 1008.2337423558075, 10033.749156271078, 10081.19350451962, 10102.34334768245, 10107.444090574942, 10149.086582207638, 3867.1298957734284, 3898.8830335089992, 3900.258950799339, 3929.057026313664, 3956.723029387973, 8087.393445491494, 8128.431009829374, 8145.104038555754, 8155.143709910374, 8170.0, 4428.645708343325, 4435.711678740871, 4440.200763862471, 4488.4165058542185, 4505.526919673387, 3711.6473934976134, 4140.047789008485, 4145.585441455831, 4148.191102734998, 4193.517745459311, 3346.0798280472577, 3362.2434952136064, 3383.2218589724503, 3387.627360990289, 3412.436947903568, 982.0523195116747, 1009.7021378693303, 1013.1438934100673, 1017.4149863828328, 1020.3928662445833, 976.6142373762324, 1209.9274043557414, 1268.949242030327, 1281.4272516862163, 1308.7055412532295, 7074.3633073023675, 7080.858382832314, 7133.857322853618, 7164.749233776793, 7172.928270717331, 461.05943874496324, 466.29822117713303, 475.19217330538225, 486.8028448478372, 488.83135318315124, 5425.945740542623, 5437.32033495813, 5442.156465747816, 5491.313585801775, 5508.724563771795, 8572.357073219533, 8966.955165224263, 9018.86471702925, 9061.68284110066, 9086.81826363469, 8938.240249578728, 8960.910390896139, 8961.0, 8962.058983806737, 9006.774830629287, 6872.587644741331, 6989.860202796017, 7015.543989640657, 7017.122859642544, 7119.1457025157315, 7079.469039821931, 7123.394511466376, 7124.821879453055, 7126.714931402893, 7142.285771422816, 7827.178146294557, 8002.359811215205, 8093.028836539653, 8187.0, 8214.917850821415, 8250.54621995796, 8259.876101858357, 8325.833483330178, 8339.749807505785, 8365.0, 6479.935200647933, 6488.643124628191, 6602.867942641216, 6839.93160068393, 6871.587704737732, 7083.043789088407, 7144.571325720473, 7153.82115447118, 7161.248068952685, 7202.243764404662, 6410.391012853772, 6523.086767852409, 6585.078089067631, 6604.3725846044545, 6614.768483103068, 6334.303226645157, 6337.683115844282, 6350.7142178603, 6404.327545607644, 6428.4857211423905, 6630.436412904957, 6639.4688424924925, 6700.564463309869, 6745.831354216184, 6759.763408280686, 6113.908291375722, 6227.782027629011, 6244.938360478639, 6245.0, 6264.248290205204, 6398.456131228898, 6404.647744374104, 6435.774747883802, 6444.806655800334, 6497.772577959749], "unit": "score", "name": "mootools.html", "value": 4208.256416963206}, {"lowerIsBetter": false, "replicates": [318.75615154406876, 320.4760217045131, 323.4323761798046, 327.99180020499483, 329.61270507154086, 6295.937040629598, 6364.554481186313, 6375.776847810327, 6383.361663833614, 6396.200474940632, 6234.594751341159, 6235.220597425322, 6240.282367527736, 6255.343188965161, 6264.279607845099, 4604.608608268301, 4668.5098064703225, 4695.506971767966, 4711.623070154379, 4745.50172231915, 4678.7426691531955, 4688.789004494789, 4695.272232803921, 4706.552877476634, 4711.787969541362, 4602.539746025387, 4657.6273898088075, 4697.9060418791605, 4699.177643912319, 4699.365585645928, 4663.207254766698, 4691.554302341272, 4691.6715829891755, 4716.858494245178, 4728.243481043051, 4026.798660067014, 4043.65628921542, 4049.392591111357, 4051.210014047262, 4057.1682805025193, 5987.580869339148, 5992.161097446361, 5993.61041532299, 5995.340512543617, 6005.669688167149, 5268.683878967274, 5441.809536666237, 5449.863753406157, 5454.809081682161, 5457.481539253765, 6554.082428460019, 6597.63712995785, 6606.570572912793, 6627.668616569153, 6645.235797883257, 4442.733435993819, 4454.8886277842985, 4456.598906098434, 4462.1968045751755, 4463.352813842007, 6898.103246577913, 6924.549904256258, 6960.825979350557, 6966.721331146748, 6971.128608923885, 4561.452625684939, 4562.270036794097, 4563.657725670588, 4565.589096981221, 4568.109218702321, 4436.7559784211535, 4549.886252843639, 4550.681452298373, 4553.954460455419, 4556.589906908394, 5351.892962140735, 5358.758855851496, 5395.136778115482, 5413.296271484682, 5434.212039254286, 6700.765473208415, 6700.966495167493, 6713.731450741916, 6734.8989765153565, 6808.183018037867, 1609.3240838847712, 1638.0990455249803, 1638.5330180898386, 1638.7623794549725, 1640.3192675039963, 1023.3041531758327, 1042.9113525350278, 1061.1404762142688, 1065.1372388365448, 1070.1011150633506, 6267.811965641038, 6270.874582508415, 6280.654563999024, 6305.4009869062365, 6305.621662700252, 6844.5208835381045, 6893.93106068943, 6898.793036208922, 6913.89629155563, 6924.549904256207, 6210.4100110489435, 6300.117983482316, 6375.4262116409745, 6397.360263973658, 6418.454431373292, 3723.646253605903, 3743.082944678571, 3744.251149770057, 3747.4940882980995, 3786.3941769316775, 7249.710011599583, 7283.198848126702, 7296.635168241567, 7301.233370496021, 7307.671154798047, 7067.010618513412, 7106.395956343666, 7112.466565007645, 7114.0, 7121.92878071223, 6952.721891124298, 7101.289871012961, 7129.429645628337, 7149.499535032602, 7308.598027108454, 6906.274841141608, 6936.930630693831, 6938.202106757585, 6939.167299924042, 6944.479164062816, 6811.284815094344, 6811.8978215325815, 6854.725810967506, 6876.518643694893, 6880.0, 7255.709771609077, 7262.273772622695, 7274.854502910018, 7286.453515986428, 7295.635218239173, 4528.750918699503, 4586.403767510203, 4633.073385323017, 4643.349931009729, 4660.557247061523, 6946.479014073863, 6949.930500695131, 6961.930380696128, 7001.299870012958, 7011.8247043822275, 6687.665616719242, 6724.529282950342, 6728.091707619409, 6729.730810767514, 6734.831629209309, 6672.399484046459, 6733.562318449285, 6733.966330168318, 6748.460123190035, 6763.391294783493, 6400.487960963205, 6616.867662646624, 6618.702158402787, 6639.767608133692, 6669.0663307136065, 6743.718693448229, 6762.42519385838, 6789.966050169717, 6795.592264464148, 6803.591784492946, 6679.799606011828, 6685.231198412245, 6690.59856408617, 6695.263521012782, 6714.764983225564], "unit": "score", "name": "prototype.html", "value": 4977.051119437489}, {"lowerIsBetter": false, "replicates": [726.5168662839212, 765.6695156695156, 794.3287921706157, 814.1736137820112, 820.7250571058695, 14114.858851411484, 14233.928830355833, 14337.498187563411, 14347.497837575687, 14376.640583985392, 13364.398602062905, 13364.465421383158, 13388.799168012487, 13393.464261429555, 13424.0, 756.1606616655508, 768.9538627682329, 771.2210667226115, 780.2041917244408, 783.2519943454016, 795.1491903663083, 795.1889073145388, 798.9720359787409, 799.5682331540961, 800.5076877720219, 823.0945959444623, 824.8432797768405, 834.7579202031403, 835.3734698975768, 836.7698882807216, 814.6578437056451, 819.3117781063905, 820.122468958215, 822.8230930349973, 823.9011318641741, 605.5972778102556, 609.1502354215888, 610.5359926455881, 611.3733423241168, 612.4916319454886, 14158.221297828615, 14194.645133871632, 14234.359453824603, 14237.857621423756, 14254.3585538651, 12467.251964882045, 12723.172993755376, 12836.1014728969, 12994.675133121653, 13252.801207981887, 9987.450690212036, 10060.547275372626, 10206.489675516195, 11040.061594764455, 11061.612843550518, 3611.9277614447565, 3645.1616128290375, 3647.1793846384617, 3655.9268814623824, 3732.682721968636, 51803.0, 52017.47982520164, 52069.0, 52457.2131418029, 53229.999999999614, 10059.0, 10096.293259471913, 10127.189824813997, 10243.692689219186, 10361.792764144675, 18002.459926202235, 18085.27658893656, 18088.27646894136, 18119.275228990955, 18131.456056318333, 7202.171750248684, 7229.7469588564145, 7336.926630733731, 7603.923960760321, 7791.883121753178, 4303.139372125587, 4308.892277693083, 4327.0480494291205, 4464.6428285737065, 4502.594766471033, 2953.852307384665, 2996.745276651509, 3006.1582756828125, 3008.2178633554995, 3008.413359394941, 536.1796451429319, 540.5837505121035, 545.9481349271813, 546.5354448718557, 547.4908335248257, 538.5153361974254, 559.0329918672543, 584.8917950179231, 670.8658268346351, 672.7342699633617, 8230.547319897463, 8260.297874680598, 8262.669493220325, 8434.325253979667, 8446.535440550706, 535.764263723968, 558.804418453538, 589.9203607512931, 603.8822429626268, 644.0468107201275, 3693.6306369362846, 3824.0, 3860.3630400984084, 3875.1668391296007, 3893.5133108361456, 47250.5274947253, 47364.0, 47553.04893902103, 47721.0, 58842.70578647165, 52120.478795211566, 53654.46345536573, 53963.730181348845, 54104.72947635237, 54266.45733542614, 47120.528794711616, 47149.292760608616, 47169.0, 47336.0, 47515.0, 7675.385969122345, 7820.726274580363, 7974.122846486998, 7979.9601001994615, 8058.234467725557, 32588.0, 33065.66934330626, 33262.833685831414, 34185.0, 34291.314173716884, 42163.578364217195, 42192.1561568773, 45808.770956145, 45971.0, 46964.295535567675, 9620.855687164838, 9753.60985560598, 9921.107100361001, 10485.633002844865, 10623.150147988297, 11752.11859110553, 11894.643160705193, 12085.879141208476, 12411.503539858666, 12427.067969902113, 10830.51262693165, 11011.504482298476, 11034.613788517363, 11037.613683521038, 11460.713482162679, 11062.944685276521, 11161.107111430903, 11221.495032723384, 11241.269317494336, 11495.54017839277, 10268.845967310346, 10428.322159059637, 10971.122310215324, 11007.779844403227, 11391.088712903114, 9474.857877131986, 9574.617015319309, 9628.75928101803, 9829.803403932025, 9949.353292035994, 9619.89816214506, 9683.66107186245, 9705.805883882424, 9730.75673108178, 9735.805283894424], "unit": "score", "name": "yui.html", "value": 6212.07795177747}], "name": "dromaeo_css", "value": 6827.487898523996}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 111.0, 113.0, 124.0, 110.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 149.0, 176.0, 127.0, 165.0, 152.0, 136.0, 176.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 165.0, 162.0, 161.0, 161.0, 162.0, 166.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 74.0, 74.0, 73.0, 77.0, 75.0, 159.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 139.0, 94.0, 94.0, 93.0, 145.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 57.0, 58.0, 58.0, 56.0, 61.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 83.0, 83.0, 84.0, 84.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 120.0, 126.0, 118.0, 127.0, 126.0, 118.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 151.0, 153.0, 148.0, 141.0, 144.0, 149.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 74.0, 72.0, 73.0, 77.0, 69.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1523.1000000000001}]} 22:20:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6827.49"}}} 22:20:07 INFO - Return code: 0 22:20:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:07 ERROR - # TBPL SUCCESS # 22:20:07 INFO - Running post-action listener: _resource_record_post_action 22:20:07 INFO - Running post-run listener: _resource_record_post_run 22:20:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 545927168; Read time: 0; Write time: 699156 22:20:08 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251875328; Read time: 0; Write time: 465596 22:20:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293896192; Read time: 0; Write time: 233524 22:20:08 INFO - Running post-run listener: _upload_blobber_files 22:20:08 INFO - Blob upload gear active. 22:20:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:20:08 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 22:20:08 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'] 22:20:08 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 22:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:09 INFO - (blobuploader) - INFO - Done attempting. 22:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:10 INFO - (blobuploader) - INFO - Done attempting. 22:20:10 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:10 INFO - Return code: 0 22:20:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc11f79b73091209795c6b6a0975da31b04b5f2e325a3b1ab415004e903f3e9f6413f784ee220e515470547d5e2dbc2f99c4693e3a4230e8de3f124277b92109", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12983afcc2d5c748659c0edd2bd755db6a02957f09edee023a848af4182c3e1e212078c56075f36e671dde2a051399379e5de17f76fd2531026b84c37b6339fc"} 22:20:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:10 INFO - Contents: 22:20:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc11f79b73091209795c6b6a0975da31b04b5f2e325a3b1ab415004e903f3e9f6413f784ee220e515470547d5e2dbc2f99c4693e3a4230e8de3f124277b92109", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12983afcc2d5c748659c0edd2bd755db6a02957f09edee023a848af4182c3e1e212078c56075f36e671dde2a051399379e5de17f76fd2531026b84c37b6339fc"} 22:20:10 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:10 INFO - Copying logs to upload dir... 22:20:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.925041 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-01 22:20:09.810635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:09.814635) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 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/fc11f79b73091209795c6b6a0975da31b04b5f2e325a3b1ab415004e903f3e9f6413f784ee220e515470547d5e2dbc2f99c4693e3a4230e8de3f124277b92109", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12983afcc2d5c748659c0edd2bd755db6a02957f09edee023a848af4182c3e1e212078c56075f36e671dde2a051399379e5de17f76fd2531026b84c37b6339fc"} build_url:https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.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/fc11f79b73091209795c6b6a0975da31b04b5f2e325a3b1ab415004e903f3e9f6413f784ee220e515470547d5e2dbc2f99c4693e3a4230e8de3f124277b92109", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/12983afcc2d5c748659c0edd2bd755db6a02957f09edee023a848af4182c3e1e212078c56075f36e671dde2a051399379e5de17f76fd2531026b84c37b6339fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:09.838805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:09.839119) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456898063.924576-1071887541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:09.921888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 22:20:09.922192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 22:20:09.922478) ========= ========= Total master_lag: 0.26 =========