builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1457135765.66 results: success (0) buildid: 20160304133200 builduid: b6c58da7280c492ca26bb6316b3b7c4c revision: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.658508) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.659013) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.659337) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.676381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.676723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.695281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.695615) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022914 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.741476) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.741786) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.742164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.742592) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 15:56:05-- 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% 23.0M=0.001s 2016-03-04 15:56:05 (23.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.844891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.845199) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.085428 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:05.942531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 15:56:05.942903) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 --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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 15:56:06,006 truncating revision to first 12 chars 2016-03-04 15:56:06,006 Setting DEBUG logging. 2016-03-04 15:56:06,006 attempt 1/10 2016-03-04 15:56:06,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a2e0878d6c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 15:56:07,307 unpacking tar archive at: mozilla-central-5a2e0878d6c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 15:56:07.571611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:07.572025) ========= echo 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5a2e0878d6c258b36b0ee8712a2afcde6ad94c78'] 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 program finished with exit code 0 elapsedTime=0.004671 script_repo_revision: '5a2e0878d6c258b36b0ee8712a2afcde6ad94c78' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:07.622793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:07.623182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 15:56:07.633386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-04 15:56:07.633668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:56:07 INFO - MultiFileLogger online at 20160304 15:56:07 in /builds/slave/test-pgo 15:56:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:56:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:56:07 INFO - {'append_to_log': False, 15:56:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:56:07 INFO - 'blob_upload_branch': 'Firefox', 15:56:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:56:07 INFO - 'branch': 'Firefox', 15:56:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:07 INFO - 'config_files': ('talos/linux_config.py',), 15:56:07 INFO - 'default_actions': ('clobber', 15:56:07 INFO - 'read-buildbot-config', 15:56:07 INFO - 'download-and-extract', 15:56:07 INFO - 'populate-webroot', 15:56:07 INFO - 'create-virtualenv', 15:56:07 INFO - 'install', 15:56:07 INFO - 'run-tests'), 15:56:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:07 INFO - 'download_minidump_stackwalk': True, 15:56:07 INFO - 'download_symbols': 'ondemand', 15:56:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:07 INFO - 'installer_path': 'installer.exe', 15:56:07 INFO - 'log_level': 'info', 15:56:07 INFO - 'log_name': 'talos', 15:56:07 INFO - 'log_to_console': True, 15:56:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:56:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:56:07 INFO - 'opt_config_files': (), 15:56:07 INFO - 'pip_index': False, 15:56:07 INFO - 'sps_profile': False, 15:56:07 INFO - 'sps_profile_interval': 0, 15:56:07 INFO - 'suite': 'dromaeojs', 15:56:07 INFO - 'system_bits': '32', 15:56:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:07 INFO - 'title': 'talos-linux64-ix-065', 15:56:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:07 INFO - 'use_talos_json': True, 15:56:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:56:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:07 INFO - 'work_dir': 'build'} 15:56:07 INFO - ##### 15:56:07 INFO - ##### Running clobber step. 15:56:07 INFO - ##### 15:56:07 INFO - Running pre-action listener: _resource_record_pre_action 15:56:07 INFO - Running main action method: clobber 15:56:07 INFO - rmtree: /builds/slave/test-pgo/build 15:56:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:56:08 INFO - Running post-action listener: _resource_record_post_action 15:56:08 INFO - ##### 15:56:08 INFO - ##### Running read-buildbot-config step. 15:56:08 INFO - ##### 15:56:08 INFO - Running pre-action listener: _resource_record_pre_action 15:56:08 INFO - Running main action method: read_buildbot_config 15:56:08 INFO - Using buildbot properties: 15:56:08 INFO - { 15:56:08 INFO - "project": "", 15:56:08 INFO - "product": "firefox", 15:56:08 INFO - "script_repo_revision": "production", 15:56:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:56:08 INFO - "repository": "", 15:56:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:56:08 INFO - "buildid": "20160304133200", 15:56:08 INFO - "pgo_build": "True", 15:56:08 INFO - "basedir": "/builds/slave/test-pgo", 15:56:08 INFO - "buildnumber": 701, 15:56:08 INFO - "slavename": "talos-linux64-ix-065", 15:56:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:56:08 INFO - "platform": "ubuntu64_hw", 15:56:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:56:08 INFO - "branch": "mozilla-central", 15:56:08 INFO - "repo_path": "mozilla-central", 15:56:08 INFO - "revision": "5a2e0878d6c258b36b0ee8712a2afcde6ad94c78", 15:56:08 INFO - "stage_platform": "linux64-pgo", 15:56:08 INFO - "builduid": "b6c58da7280c492ca26bb6316b3b7c4c", 15:56:08 INFO - "slavebuilddir": "test" 15:56:08 INFO - } 15:56:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:56:08 INFO - Running post-action listener: _resource_record_post_action 15:56:08 INFO - ##### 15:56:08 INFO - ##### Running download-and-extract step. 15:56:08 INFO - ##### 15:56:08 INFO - Running pre-action listener: _resource_record_pre_action 15:56:08 INFO - Running main action method: download_and_extract 15:56:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:56: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')]} 15:56:08 INFO - https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:56:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:56:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:56:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:09 INFO - Downloaded 1448 bytes. 15:56:09 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 15:56:09 INFO - Using the following test package requirements: 15:56:09 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:56:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:56:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'jsshell-linux-x86_64.zip'], 15:56:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:56:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:56:09 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:56:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:56:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:56:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:56: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')]} 15:56:09 INFO - https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:10 INFO - Downloaded 23396618 bytes. 15:56:10 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'] 15:56:10 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 15:56:11 INFO - Return code: 0 15:56:11 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 15:56: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')]} 15:56:11 INFO - https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:13 INFO - Downloaded 23396618 bytes. 15:56:13 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'] 15:56:13 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 15:56:14 INFO - Return code: 0 15:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:14 INFO - https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:15 INFO - Downloaded 10803659 bytes. 15:56:15 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'] 15:56:15 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 15:56:15 INFO - Return code: 0 15:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:15 INFO - https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P71NCPdGRB-98lQ6M-mjmQ/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 15:56:16 INFO - Downloaded 56120988 bytes. 15:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:56:16 INFO - mkdir: /builds/slave/test-pgo/properties 15:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:56:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:56:16 INFO - Contents: 15:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:56:17 INFO - Running post-action listener: _resource_record_post_action 15:56:17 INFO - Running post-action listener: set_extra_try_arguments 15:56:17 INFO - ##### 15:56:17 INFO - ##### Running populate-webroot step. 15:56:17 INFO - ##### 15:56:17 INFO - Running pre-action listener: _resource_record_pre_action 15:56:17 INFO - Running main action method: populate_webroot 15:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:17 INFO - '--tppagecycles', 15:56:17 INFO - '7'], 15:56:17 INFO - 'tests': ['tsvgm']}}, 15:56:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:56:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:56:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:56:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'tests': ['damp', 'tps']}, 15:56:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['damp', 'tps']}, 15:56:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:17 INFO - 'other': {'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'other_l64': {'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'other_nol64': {'tests': ['a11yr', 15:56:17 INFO - 'ts_paint', 15:56:17 INFO - 'tpaint', 15:56:17 INFO - 'sessionrestore', 15:56:17 INFO - 'sessionrestore_no_auto_restore']}, 15:56:17 INFO - 'svgr': {'tests': ['tsvgx', 15:56:17 INFO - 'tsvgr_opacity', 15:56:17 INFO - 'tart', 15:56:17 INFO - 'tscrollx', 15:56:17 INFO - 'cart']}, 15:56:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['tsvgx', 15:56:17 INFO - 'tsvgr_opacity', 15:56:17 INFO - 'tart', 15:56:17 INFO - 'tscrollx', 15:56:17 INFO - 'cart']}, 15:56:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'tests': ['tp5o']}, 15:56:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'talos_options': ['--e10s'], 15:56:17 INFO - 'tests': ['tp5o']}, 15:56:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'talos_options': ['--xperf_path', 15:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:17 INFO - 'tests': ['tp5n']}, 15:56:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:17 INFO - 'talos_options': ['--e10s', 15:56:17 INFO - '--xperf_path', 15:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:17 INFO - 'tests': ['tp5n']}}, 15:56:17 INFO - 'talos.zip': {'path': '', 15:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:17 INFO - Running post-action listener: _resource_record_post_action 15:56:17 INFO - ##### 15:56:17 INFO - ##### Running create-virtualenv step. 15:56:17 INFO - ##### 15:56:17 INFO - Running pre-action listener: _resource_record_pre_action 15:56:17 INFO - Running main action method: create_virtualenv 15:56:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:56:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:17 INFO - Using real prefix '/usr' 15:56:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:20 INFO - Installing pip.................done. 15:56:20 INFO - Return code: 0 15:56:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:20 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 15:56:20 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 15:56:20 INFO - Using env: {'DISPLAY': ':0', 15:56:20 INFO - 'HOME': '/home/cltbld', 15:56:20 INFO - 'LANG': 'en_US.UTF-8', 15:56:20 INFO - 'LANGUAGE': 'en_US:en', 15:56:20 INFO - 'LOGNAME': 'cltbld', 15:56:20 INFO - 'MAIL': '/var/mail/cltbld', 15:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:20 INFO - 'MOZ_NO_REMOTE': '1', 15:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:20 INFO - 'NO_EM_RESTART': '1', 15:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:20 INFO - 'SHELL': '/bin/bash', 15:56:20 INFO - 'SHLVL': '1', 15:56:20 INFO - 'TERM': 'linux', 15:56:20 INFO - 'TMOUT': '86400', 15:56:20 INFO - 'USER': 'cltbld', 15:56:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:20 INFO - '_': '/tools/buildbot/bin/python'} 15:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:56:20 INFO - Cleaning up... 15:56:20 INFO - Return code: 0 15:56:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:20 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:20 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 15:56:20 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 15:56:20 INFO - Using env: {'DISPLAY': ':0', 15:56:20 INFO - 'HOME': '/home/cltbld', 15:56:20 INFO - 'LANG': 'en_US.UTF-8', 15:56:20 INFO - 'LANGUAGE': 'en_US:en', 15:56:20 INFO - 'LOGNAME': 'cltbld', 15:56:20 INFO - 'MAIL': '/var/mail/cltbld', 15:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:20 INFO - 'MOZ_NO_REMOTE': '1', 15:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:20 INFO - 'NO_EM_RESTART': '1', 15:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:20 INFO - 'SHELL': '/bin/bash', 15:56:20 INFO - 'SHLVL': '1', 15:56:20 INFO - 'TERM': 'linux', 15:56:20 INFO - 'TMOUT': '86400', 15:56:20 INFO - 'USER': 'cltbld', 15:56:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:20 INFO - '_': '/tools/buildbot/bin/python'} 15:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:20 INFO - Downloading/unpacking psutil>=0.7.1 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:22 INFO - Installing collected packages: psutil 15:56:22 INFO - Running setup.py install for psutil 15:56:22 INFO - building 'psutil._psutil_linux' extension 15:56:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:56:22 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 15:56:22 INFO - building 'psutil._psutil_posix' extension 15:56:22 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 15:56:22 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 15:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:23 INFO - Successfully installed psutil 15:56:23 INFO - Cleaning up... 15:56:23 INFO - Return code: 0 15:56:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:23 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:23 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 15:56:23 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 15:56:23 INFO - Using env: {'DISPLAY': ':0', 15:56:23 INFO - 'HOME': '/home/cltbld', 15:56:23 INFO - 'LANG': 'en_US.UTF-8', 15:56:23 INFO - 'LANGUAGE': 'en_US:en', 15:56:23 INFO - 'LOGNAME': 'cltbld', 15:56:23 INFO - 'MAIL': '/var/mail/cltbld', 15:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:23 INFO - 'MOZ_NO_REMOTE': '1', 15:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:23 INFO - 'NO_EM_RESTART': '1', 15:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:23 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:23 INFO - 'SHELL': '/bin/bash', 15:56:23 INFO - 'SHLVL': '1', 15:56:23 INFO - 'TERM': 'linux', 15:56:23 INFO - 'TMOUT': '86400', 15:56:23 INFO - 'USER': 'cltbld', 15:56:23 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:23 INFO - '_': '/tools/buildbot/bin/python'} 15:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:56:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:56:25 INFO - Installing collected packages: mozsystemmonitor 15:56:25 INFO - Running setup.py install for mozsystemmonitor 15:56:25 INFO - Successfully installed mozsystemmonitor 15:56:25 INFO - Cleaning up... 15:56:25 INFO - Return code: 0 15:56:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:25 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:25 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 15:56:25 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 15:56:25 INFO - Using env: {'DISPLAY': ':0', 15:56:25 INFO - 'HOME': '/home/cltbld', 15:56:25 INFO - 'LANG': 'en_US.UTF-8', 15:56:25 INFO - 'LANGUAGE': 'en_US:en', 15:56:25 INFO - 'LOGNAME': 'cltbld', 15:56:25 INFO - 'MAIL': '/var/mail/cltbld', 15:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:25 INFO - 'MOZ_NO_REMOTE': '1', 15:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:25 INFO - 'NO_EM_RESTART': '1', 15:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:25 INFO - 'SHELL': '/bin/bash', 15:56:25 INFO - 'SHLVL': '1', 15:56:25 INFO - 'TERM': 'linux', 15:56:25 INFO - 'TMOUT': '86400', 15:56:25 INFO - 'USER': 'cltbld', 15:56:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:25 INFO - '_': '/tools/buildbot/bin/python'} 15:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:56:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - Downloading docopt-0.6.1.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:28 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:28 INFO - Running setup.py install for blobuploader 15:56:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:56:28 INFO - Running setup.py install for requests 15:56:28 INFO - Running setup.py install for docopt 15:56:28 INFO - Successfully installed blobuploader requests docopt 15:56:28 INFO - Cleaning up... 15:56:28 INFO - Return code: 0 15:56:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:28 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:28 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 15:56:28 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 15:56:28 INFO - Using env: {'DISPLAY': ':0', 15:56:28 INFO - 'HOME': '/home/cltbld', 15:56:28 INFO - 'LANG': 'en_US.UTF-8', 15:56:28 INFO - 'LANGUAGE': 'en_US:en', 15:56:28 INFO - 'LOGNAME': 'cltbld', 15:56:28 INFO - 'MAIL': '/var/mail/cltbld', 15:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:28 INFO - 'MOZ_NO_REMOTE': '1', 15:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:28 INFO - 'NO_EM_RESTART': '1', 15:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:28 INFO - 'SHELL': '/bin/bash', 15:56:28 INFO - 'SHLVL': '1', 15:56:28 INFO - 'TERM': 'linux', 15:56:28 INFO - 'TMOUT': '86400', 15:56:28 INFO - 'USER': 'cltbld', 15:56:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:28 INFO - '_': '/tools/buildbot/bin/python'} 15:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:56:28 INFO - Running setup.py (path:/tmp/pip-PRQ0YR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:56:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:56:28 INFO - Running setup.py (path:/tmp/pip-B2Y1Wx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:56:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:56:28 INFO - Running setup.py (path:/tmp/pip-XacX6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:56:29 INFO - Running setup.py (path:/tmp/pip-QXM8dW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:56:29 INFO - Running setup.py (path:/tmp/pip-iStwBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:56:29 INFO - Running setup.py (path:/tmp/pip-n3eAzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:56:29 INFO - Running setup.py (path:/tmp/pip-8P18OR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:56:29 INFO - Running setup.py (path:/tmp/pip-InhU94-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:56:29 INFO - Running setup.py (path:/tmp/pip-E4v9nZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:56:29 INFO - Running setup.py (path:/tmp/pip-Kwl07T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:56:29 INFO - Running setup.py (path:/tmp/pip-M1UpTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:56:29 INFO - Running setup.py (path:/tmp/pip-HOwwOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:56:29 INFO - Running setup.py (path:/tmp/pip-fidfdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:56:29 INFO - Running setup.py (path:/tmp/pip-fMX7Cd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:56:29 INFO - Running setup.py (path:/tmp/pip-n5NHLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:56:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:56:29 INFO - Running setup.py (path:/tmp/pip-OqcHug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:56:30 INFO - Running setup.py (path:/tmp/pip-y7ustI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:56:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:30 INFO - Running setup.py install for manifestparser 15:56:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Running setup.py install for mozcrash 15:56:30 INFO - Running setup.py install for mozdebug 15:56:30 INFO - Running setup.py install for mozdevice 15:56:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Running setup.py install for mozfile 15:56:30 INFO - Running setup.py install for mozhttpd 15:56:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Running setup.py install for mozinfo 15:56:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Running setup.py install for mozInstall 15:56:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:56:30 INFO - Running setup.py install for mozleak 15:56:30 INFO - Running setup.py install for mozlog 15:56:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Running setup.py install for moznetwork 15:56:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Running setup.py install for mozprocess 15:56:31 INFO - Running setup.py install for mozprofile 15:56:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Running setup.py install for mozrunner 15:56:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Running setup.py install for mozscreenshot 15:56:31 INFO - Running setup.py install for moztest 15:56:31 INFO - Running setup.py install for mozversion 15:56:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:56:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:31 INFO - Cleaning up... 15:56:31 INFO - Return code: 0 15:56:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:56: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')]} 15:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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')]} 15:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:31 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:31 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 15:56:31 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 15:56:31 INFO - Using env: {'DISPLAY': ':0', 15:56:31 INFO - 'HOME': '/home/cltbld', 15:56:31 INFO - 'LANG': 'en_US.UTF-8', 15:56:31 INFO - 'LANGUAGE': 'en_US:en', 15:56:31 INFO - 'LOGNAME': 'cltbld', 15:56:31 INFO - 'MAIL': '/var/mail/cltbld', 15:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:31 INFO - 'MOZ_NO_REMOTE': '1', 15:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:31 INFO - 'NO_EM_RESTART': '1', 15:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:31 INFO - 'SHELL': '/bin/bash', 15:56:31 INFO - 'SHLVL': '1', 15:56:31 INFO - 'TERM': 'linux', 15:56:31 INFO - 'TMOUT': '86400', 15:56:31 INFO - 'USER': 'cltbld', 15:56:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:31 INFO - '_': '/tools/buildbot/bin/python'} 15:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:56:32 INFO - Running setup.py (path:/tmp/pip-Vaxho9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:56:32 INFO - Running setup.py (path:/tmp/pip-YpTYGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:56:32 INFO - Running setup.py (path:/tmp/pip-Tp1aLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:56:32 INFO - Running setup.py (path:/tmp/pip-OYFj0k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:56:32 INFO - Running setup.py (path:/tmp/pip-9ry1ot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:56:32 INFO - Running setup.py (path:/tmp/pip-5621gf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:56:32 INFO - Running setup.py (path:/tmp/pip-PNTepA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:56:32 INFO - Running setup.py (path:/tmp/pip-ZXRe4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:56:32 INFO - Running setup.py (path:/tmp/pip-tNewGI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:56:32 INFO - Running setup.py (path:/tmp/pip-RxiIpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:56:32 INFO - Running setup.py (path:/tmp/pip-6ucUSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:56:32 INFO - Running setup.py (path:/tmp/pip-FcTP1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:56:32 INFO - Running setup.py (path:/tmp/pip-wkRAu9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:56:33 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)) 15:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:56:33 INFO - Running setup.py (path:/tmp/pip-FbqnfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:56:33 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)) 15:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:56:33 INFO - Running setup.py (path:/tmp/pip-u0IU4p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:56:33 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)) 15:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:56:33 INFO - Running setup.py (path:/tmp/pip-o6Vttv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:56:33 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)) 15:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:56:33 INFO - Running setup.py (path:/tmp/pip-UXW27U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:56:33 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)) 15:56:33 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)) 15:56:33 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)) 15:56:33 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)) 15:56:33 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)) 15:56:33 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)) 15:56:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:36 INFO - Downloading blessings-1.6.tar.gz 15:56:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:36 INFO - Installing collected packages: blessings 15:56:36 INFO - Running setup.py install for blessings 15:56:36 INFO - Successfully installed blessings 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:56:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:56:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:56:36 INFO - Reading from file tmpfile_stdout 15:56:36 INFO - Current package versions: 15:56:36 INFO - argparse == 1.2.1 15:56:36 INFO - blessings == 1.6 15:56:36 INFO - blobuploader == 1.2.4 15:56:36 INFO - docopt == 0.6.1 15:56:36 INFO - manifestparser == 1.1 15:56:36 INFO - mozInstall == 1.12 15:56:36 INFO - mozcrash == 0.16 15:56:36 INFO - mozdebug == 0.1 15:56:36 INFO - mozdevice == 0.48 15:56:36 INFO - mozfile == 1.2 15:56:36 INFO - mozhttpd == 0.7 15:56:36 INFO - mozinfo == 0.9 15:56:36 INFO - mozleak == 0.1 15:56:36 INFO - mozlog == 3.1 15:56:36 INFO - moznetwork == 0.27 15:56:36 INFO - mozprocess == 0.22 15:56:36 INFO - mozprofile == 0.28 15:56:36 INFO - mozrunner == 6.11 15:56:36 INFO - mozscreenshot == 0.1 15:56:36 INFO - mozsystemmonitor == 0.0 15:56:36 INFO - moztest == 0.7 15:56:36 INFO - mozversion == 1.4 15:56:36 INFO - psutil == 3.1.1 15:56:36 INFO - requests == 1.2.3 15:56:36 INFO - wsgiref == 0.1.2 15:56:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:36 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:36 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 15:56:36 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 15:56:36 INFO - Using env: {'DISPLAY': ':0', 15:56:36 INFO - 'HOME': '/home/cltbld', 15:56:36 INFO - 'LANG': 'en_US.UTF-8', 15:56:36 INFO - 'LANGUAGE': 'en_US:en', 15:56:36 INFO - 'LOGNAME': 'cltbld', 15:56:36 INFO - 'MAIL': '/var/mail/cltbld', 15:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:36 INFO - 'MOZ_NO_REMOTE': '1', 15:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:36 INFO - 'NO_EM_RESTART': '1', 15:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:36 INFO - 'SHELL': '/bin/bash', 15:56:36 INFO - 'SHLVL': '1', 15:56:36 INFO - 'TERM': 'linux', 15:56:36 INFO - 'TMOUT': '86400', 15:56:36 INFO - 'USER': 'cltbld', 15:56:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:36 INFO - '_': '/tools/buildbot/bin/python'} 15:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 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)) 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:36 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:36 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 15:56:36 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 15:56:36 INFO - Using env: {'DISPLAY': ':0', 15:56:36 INFO - 'HOME': '/home/cltbld', 15:56:36 INFO - 'LANG': 'en_US.UTF-8', 15:56:36 INFO - 'LANGUAGE': 'en_US:en', 15:56:36 INFO - 'LOGNAME': 'cltbld', 15:56:36 INFO - 'MAIL': '/var/mail/cltbld', 15:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:36 INFO - 'MOZ_NO_REMOTE': '1', 15:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:36 INFO - 'NO_EM_RESTART': '1', 15:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:36 INFO - 'SHELL': '/bin/bash', 15:56:36 INFO - 'SHLVL': '1', 15:56:36 INFO - 'TERM': 'linux', 15:56:36 INFO - 'TMOUT': '86400', 15:56:36 INFO - 'USER': 'cltbld', 15:56:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:36 INFO - '_': '/tools/buildbot/bin/python'} 15:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:37 INFO - Downloading/unpacking jsonschema 15:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:56:38 INFO - Downloading/unpacking functools32 (from jsonschema) 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:56:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:56:39 INFO - warning: no files found matching '*.txt' 15:56:39 INFO - no previously-included directories found matching 'build' 15:56:39 INFO - no previously-included directories found matching 'dist' 15:56:39 INFO - no previously-included directories found matching '.git*' 15:56:39 INFO - Installing collected packages: jsonschema, functools32 15:56:39 INFO - Running setup.py install for functools32 15:56:39 INFO - warning: no files found matching '*.txt' 15:56:39 INFO - no previously-included directories found matching 'build' 15:56:39 INFO - no previously-included directories found matching 'dist' 15:56:39 INFO - no previously-included directories found matching '.git*' 15:56:39 INFO - Successfully installed jsonschema functools32 15:56:39 INFO - Cleaning up... 15:56:39 INFO - Return code: 0 15:56:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:39 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 0x7fd7195bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28df6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:56:39 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 15:56:39 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 15:56:39 INFO - Using env: {'DISPLAY': ':0', 15:56:39 INFO - 'HOME': '/home/cltbld', 15:56:39 INFO - 'LANG': 'en_US.UTF-8', 15:56:39 INFO - 'LANGUAGE': 'en_US:en', 15:56:39 INFO - 'LOGNAME': 'cltbld', 15:56:39 INFO - 'MAIL': '/var/mail/cltbld', 15:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:39 INFO - 'MOZ_NO_REMOTE': '1', 15:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:39 INFO - 'NO_EM_RESTART': '1', 15:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:39 INFO - 'SHELL': '/bin/bash', 15:56:39 INFO - 'SHLVL': '1', 15:56:39 INFO - 'TERM': 'linux', 15:56:39 INFO - 'TMOUT': '86400', 15:56:39 INFO - 'USER': 'cltbld', 15:56:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:39 INFO - '_': '/tools/buildbot/bin/python'} 15:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:39 INFO - Downloading/unpacking flake8 15:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:56:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:56:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:56:42 INFO - no previously-included directories found matching 'docs/_build' 15:56:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:56:42 INFO - Running setup.py install for pep8 15:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:56:42 INFO - no previously-included directories found matching 'docs/_build' 15:56:42 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:56:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:56:42 INFO - Cleaning up... 15:56:42 INFO - Return code: 0 15:56:42 INFO - Running post-action listener: _resource_record_post_action 15:56:42 INFO - Running post-action listener: _start_resource_monitoring 15:56:42 INFO - Starting resource monitoring. 15:56:42 INFO - ##### 15:56:42 INFO - ##### Running install step. 15:56:42 INFO - ##### 15:56:42 INFO - Running pre-action listener: _resource_record_pre_action 15:56:42 INFO - Running main action method: install 15:56:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:56:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:56:42 INFO - Reading from file tmpfile_stdout 15:56:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:56:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:56:42 INFO - Reading from file tmpfile_stdout 15:56:42 INFO - Output received: 15:56:42 INFO - Usage: mozinstall [options] installer 15:56:42 INFO - Options: 15:56:42 INFO - -h, --help show this help message and exit 15:56:42 INFO - -d DEST, --destination=DEST 15:56:42 INFO - Directory to install application into. [default: 15:56:42 INFO - "/builds/slave/test-pgo"] 15:56:42 INFO - --app=APP Application being installed. [default: firefox] 15:56:42 INFO - mkdir: /builds/slave/test-pgo/build/application 15:56:42 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'] 15:56:42 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 15:56:58 INFO - Reading from file tmpfile_stdout 15:56:58 INFO - Output received: 15:56:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:56:58 INFO - Running post-action listener: _resource_record_post_action 15:56:58 INFO - ##### 15:56:58 INFO - ##### Running run-tests step. 15:56:58 INFO - ##### 15:56:58 INFO - Running pre-action listener: _resource_record_pre_action 15:56:58 INFO - Running main action method: run_tests 15:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:56:58 INFO - Python 2.7.3 15:56:58 INFO - Return code: 0 15:56:58 INFO - grabbing minidump binary from tooltool 15:56: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')]} 15:56:58 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 0x296e920>, '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 0x296f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:56:58 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 15:56:58 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 15:56:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:58 INFO - Return code: 0 15:56:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:56:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:56:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:56:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:56:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:56:59 INFO - Return code: 0 15:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:56:59 INFO - Using env: {'DISPLAY': ':0', 15:56:59 INFO - 'HOME': '/home/cltbld', 15:56:59 INFO - 'LANG': 'en_US.UTF-8', 15:56:59 INFO - 'LANGUAGE': 'en_US:en', 15:56:59 INFO - 'LOGNAME': 'cltbld', 15:56:59 INFO - 'MAIL': '/var/mail/cltbld', 15:56:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:56:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:59 INFO - 'MOZ_NO_REMOTE': '1', 15:56:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:59 INFO - 'NO_EM_RESTART': '1', 15:56:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:56:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:56:59 INFO - 'SHELL': '/bin/bash', 15:56:59 INFO - 'SHLVL': '1', 15:56:59 INFO - 'TERM': 'linux', 15:56:59 INFO - 'TMOUT': '86400', 15:56:59 INFO - 'USER': 'cltbld', 15:56:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234', 15:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:59 INFO - '_': '/tools/buildbot/bin/python'} 15:56:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:57:00 INFO - mozversion application_buildid: 20160304133200 15:57:00 INFO - mozversion application_changeset: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 15:57:00 INFO - mozversion application_display_name: Nightly 15:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:00 INFO - mozversion application_name: Firefox 15:57:00 INFO - mozversion application_remotingname: firefox 15:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:57:00 INFO - mozversion application_vendor: Mozilla 15:57:00 INFO - mozversion application_version: 47.0a1 15:57:00 INFO - mozversion platform_buildid: 20160304133200 15:57:00 INFO - mozversion platform_changeset: 5a2e0878d6c258b36b0ee8712a2afcde6ad94c78 15:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:57:00 INFO - mozversion platform_version: 47.0a1 15:57:00 INFO - using testdate: 1457135820 15:57:00 INFO - actual date: 1457135820 15:57:00 INFO - starting webserver on 'localhost:44987' 15:57:00 INFO - SUITE-START | Running 2 tests 15:57:00 INFO - TEST-START | dromaeo_css 15:57:00 INFO - operating with platform_type : linux_ 15:57:00 INFO - Initialising browser for dromaeo_css test... 15:57:00 INFO - TEST-INFO | started process 29405 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LnYMG/profile http://localhost:44987/getInfo.html) 15:57:04 INFO - PROCESS | 29405 | __metrics Screen width/height:1600/1200 15:57:04 INFO - PROCESS | 29405 | colorDepth:24 15:57:04 INFO - PROCESS | 29405 | Browser inner width/height: 1024/697 15:57:04 INFO - PROCESS | 29405 | __metrics 15:57:05 INFO - PROCESS | 29405 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:06 INFO - TEST-INFO | 29405: exit 0 15:57:06 INFO - Browser initialized. 15:57:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:06 INFO - TEST-INFO | started process 29504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LnYMG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:17 INFO - PROCESS | 29504 | RSS: Main: 154075136 15:57:17 INFO - PROCESS | 29504 | 15:58:09 INFO - PROCESS | 29504 | 1457135889149 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:00:16 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44987/tests/dromaeo/cssquery-ext.html) 16:00:18 INFO - PROCESS | 29504 | RSS: Main: 266735616 16:00:18 INFO - PROCESS | 29504 | 16:03:20 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-ext.html (next: http://localhost:44987/tests/dromaeo/cssquery-jquery.html) 16:03:20 INFO - PROCESS | 29504 | RSS: Main: 236978176 16:03:20 INFO - PROCESS | 29504 | 16:06:22 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44987/tests/dromaeo/cssquery-mootools.html) 16:06:23 INFO - PROCESS | 29504 | RSS: Main: 232902656 16:06:23 INFO - PROCESS | 29504 | 16:09:25 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44987/tests/dromaeo/cssquery-prototype.html) 16:09:25 INFO - PROCESS | 29504 | RSS: Main: 212770816 16:09:25 INFO - PROCESS | 29504 | 16:12:28 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44987/tests/dromaeo/cssquery-yui.html) 16:12:28 INFO - PROCESS | 29504 | RSS: Main: 218079232 16:12:28 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | Cycle 1(1): loaded http://localhost:44987/tests/dromaeo/cssquery-yui.html (next: http://localhost:44987/tests/dromaeo/cssquery-dojo.html) 16:15:31 INFO - PROCESS | 29504 | RSS: Main: 322916352 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | __start_tp_report 16:15:31 INFO - PROCESS | 29504 | _x_x_mozilla_page_load 16:15:31 INFO - PROCESS | 29504 | _x_x_mozilla_page_load_details 16:15:31 INFO - PROCESS | 29504 | |i|pagename|runs| 16:15:31 INFO - PROCESS | 29504 | |0;dojo.html;3083.8920637777674;3152.0701393089034;3197.6482586915436;3202.5836641236638;3228.5641438405814;5080.618953578478;5144.845654630362;5190.948090519094;5196.532312091911;5221.451747566508;5206.8698282542955;5215.765290561924;5217.530422261995;5246.632735708502;5280.683159010462;4666.673332866701;4716.339712440253;4767.356406885061;4825.155597770394;4859.538343857328;4679.695819771704;4728.148933192024;4802.663813533054;4805.351277577534;4918;4762.1428142934255;4771.9522804772205;4775.522447755214;4805.327254184417;4809.807607695688;4772.379590653228;4776.8566942991765;4778.0205057963385;4800.135975524404;4827.51724827518;4615.630749540029;4653.953460465385;4728.739919304471;4760.238361862085;4775.068861571995;4986.601071914238;4994.700317980896;5006.524380183877;5007.949920500785;5043.722595257259;5541.251930989305;5548.77804887804;5549.889002219973;5554.305711786027;5571.832845014656;5427.864303392407;5557.166425036236;5606.21512988182;5641.323041235037;5699.57253206007;5254.290670759437;5263.6841789492755;5265.815696450644;5273.630845840793;5276.023935571931;5591.30108736408;5725.627834190847;5727.140928860705;5729.255196824386;5731.283589551306;5521.337439507285;5552.250446189793;5553.250311208016;5567.972160139173;5603.411641777555;5497.752601132958;5502.174673798882;5502.779888804403;5506.421825708323;5507.091329930597;5393.406725260218;5472.799856998175;5484.396716361197;5486.725663716798;5523.199136125239;5585.916211256835;5594.24477695514;5594.916076258859;5604.047311956977;5629.634073785191;4258.318669012943;4263.16868210696;4264.7654379009455;4272.658187345005;4307.569243075667;3747.213085252073;3770.453284273765;3801.5438147422487;3874.535055793323;3889.1638297766117;5263.421023687468;5281.841544753664;5284.9735751320995;5297.390800058042;5320.255164277004;5572.3870374258795;5588.077967135378;5591.440855914376;5597.608167428241;5609.074502707089;5155.355580552431;5220.086484865209;5270.235815806764;5300.1254792958725;5304.602154838402;4763.404574428197;4768.499307572724;4776.283557466408;4786.16242157621;4824.855254342376;5905.173275741399;5924.081767326072;5928;5930.9406905931255;5931.139984702194;5412.079946409041;5431.538319242909;5432;5507.614466987273;5508.779648814003;5909.438603332676;5913.5564832636865;5923.881522369615;5929;5930.199423077829;5283.418823929288;5555.972220138873;5560.499555040065;5567.331920169444;5571.3592936811165;5583.469570390806;5601.355844077983;5606.831795045992;5611.354694210218;5663.716814159193;5430.294061771944;5440.483154100354;5441.401445841034;5444.673319600836;5445.264889239902;5326.0945639240645;5412.350517937873;5440.8639784004135;5445.183222516495;5493.890122197614;5280.3663560373;5287.788488460573;5293.708846013506;5295.099833028471;5328.8934221314585;5361.624686271924;5363.714120899775;5392.973035134799;5404.297441332602;5413.485718856702;5153.330067091254;5305.495977882095;5315.681059136464;5350;5373.570114390917 16:15:31 INFO - PROCESS | 29504 | |1;ext.html;520.5705293133163;529.0529951387017;540.6972095626451;549.8872731090125;592.1502643706284;35130.47304290435;35752.10619734508;35815.64184358156;35892.64107358926;35920.64079359206;39877.202455950865;40238;40387;40412.39381409274;40482.39276410856;8432.83134337313;8687.30501559877;8696.956515217415;8704.347173961947;8709.085546017672;8543.102974187714;8684;8684.826303473927;8928.241099506517;8935.240504557089;8777.253933415668;8792.912070879305;8826.735197944072;8851.911480885205;8854.02605713371;8845.248153906894;8918;8926.73219803407;8933.240674542672;8933.374663773538;8769.605367758402;8899.288056955427;8902.955485222597;8912.55437228136;8913.28693704502;40548;40900.1819963602;40989.385159222635;41028.179436411105;41089.79455102735;3112.59536260287;3129.8435078246225;3318.0875259303643;3421.8460169292193;3716.721245906541;29725.027497250318;30369;30554.38891222163;30634.084012138796;30807;3354.563906692139;3380.3915295246848;3390.6948374646154;3431.0555793201447;3469.0633528947296;253900;254805.99999999814;255511;256352;256695;58239.4176058234;58254;58490.70754646199;58670.41329586735;58685.70657146687;61830.381696183365;65812.67093664501;67321.32678673249;67389.32610673929;67390.989135163;15519.922400387926;15704.214789260719;15711.292991815395;15714.371425142866;15722.13528255957;11876.406179690981;11916.582919597773;11929.761404771856;11932.880671193177;11939;20709.792902071087;21049.473763156042;21225.893870530857;21250;21261.57476850485;7661.693532258759;7788.805279868048;7803.960980195063;7867.291943725092;7886.802829929297;858.5406807358033;909.1771946388529;910.6084383714933;963.9710808675751;1006.7483129217695;28029.159125226277;28221.43557128846;28517.144485665463;28533.28666783347;28719.56920646192;917.4449458077901;952.4142652268805;999.8900120986685;1003.4481035430484;1077.2028698763015;14869.776953345709;15018.174000429863;15132.167730774692;15211.467598634215;15254.694906102039;282198;283324;283924;286532;287906;49884.50115498871;50381.748091260044;50431.747841260556;50446;50455.74772126189;1167.0896700573567;1170.3329102411544;1206.6440400081997;1234.111439763369;1354.3499120422055;26495.482929121703;28305.57541636918;28314.150575482767;28396.574051388834;28864.567031494124;39303.21393572055;39401.60598393979;39534.20931581295;39731.80134099311;39962.40056399098;171599;176610;179294;180927;181447;27070;30184.849075754482;30504.542431863098;30901.536476952413;31896.521552176273;40089.1982160361;40545.594544054184;40940.79529602333;41407.171856563305;41548.3767743478;33614.83192584021;34400.48399274063;34617;35092.82453587716;35260.47109293414;32967;34347.4847877287;34592.270386481076;34764.47853282253;34797.82601086979;33438.49842252417;33951.66048339485;34186.65813341934;34513.13717157091;34773;31811.522827157147;34679.65320346764;34680.65319346875;34828.82585587056;35102.12244693903;23994.40013999664;25364.746352536975;25422.618660719734;25813.870930645226;25944.351391215372 16:15:31 INFO - PROCESS | 29504 | |2;jquery.html;348.23214811340995;352.32881361007276;356.88936429706774;357.13395017083576;358.541067433685;16470.423535176273;16633.750493742602;17714.91142544287;17816.287348506045;17937.910310448464;16284.26720797567;16532.504024879243;16802.747958780597;16817.495475135765;16821.074840883746;5192.88353004104;5255.0803609368395;5480.424555421683;5501.092319767234;5507.697076660782;5395.78416863325;5449.128139497681;5449.509544141027;5451.672899626015;5493.890122197554;5423.918641220384;5431;5516.172574113895;5683.5169010634145;5754.827355179351;5615.157726341041;5668.68822214778;5670.064439367499;5706.743196556165;5730.283714535683;5290.127129023706;5309.840704778863;5312.5218730314455;5323;5329.7601607927345;11651;11729;11833.704157396134;12298.692532686666;12777.169483983604;1920.1839218332293;2037.6128535578341;2059.5366042640435;2685.449269611365;2705.066751970567;9195.310351723647;9255.861162082507;9306.53467326631;9358.57886395114;9501.714948551555;1750.0724615953566;1791.8779456973584;1792.363710882644;1820.8816426932208;1891.4042076745782;57537.13694294589;59541.40458595402;60192;62156;63969.36030639727;9812.901870981199;9936.205103591696;10095.24285678577;10191.184705223564;10194.286399951932;13258;13363.797258246805;13373;13373.53192638253;13374.531891383755;7170.39051680613;7270.8182295441975;7419.8145046374275;7536.284053014955;7540.736074237376;7043.9786230996215;7067.363937245673;7102.218755936843;7167.641617919187;7245.746398876119;4427.911441771146;4439.311906654474;4449.688521803508;4458.464984201916;4525.0497395546645;1812.56498440376;1825.616620509708;1828.506303298102;1844.5665268661853;1851.1022154255174;870.2254993056185;875.9124087591317;876.2157868707471;956.4882787708682;960.9135177833889;13813.723725525433;13869.514566990309;16027.759583606256;16516.339346426248;16537.751933721003;824.9752507424787;831.0775039705921;860.2086080805674;892.5180402582532;924.6994726713845;8901.154390332907;9005.369624126248;9177.495237761854;9220.90779092214;9336.906630933603;419731;422450;424366;425465;437932;74884.62557687177;75720;77120;78188;78603;1047.198892846988;1050.0864248104199;1070.2882583082164;1074.435921141407;1074.7098283463422;13749.381277842322;14121.576352709435;14223.502177423741;14474.927625361806;14515.782263265848;24939.376515587257;30512.23719406944;32818.34363312673;33045.83477082599;33658.831705841316;45446;49764.033035374356;49837;50057;50064.24903626522;7154.534955227893;7159.498835081495;7280.1991780903;7376.336129748348;7397.927300541499;8761.430507017278;10984.835227471434;10999.120070394509;11046.392448415414;11232.438378081226;9614.230861531201;9655.806883862424;9656.130948214695;9711.611535538783;9955.104040636377;7631.275028872248;7877.054753429625;9787.16809071237;9820.950895245478;10054.748631284276;9680.322377433513;9729.929707732286;9738.464384458639;10059.295849290773;10098.495075246356;7045.894311585228;7103.9289607103265;7138.892916606359;7188.209296977433;7416.406687465098;9415;9497.715068547956;9620.470874101991;9632.711018669452;9798.412095274307 16:15:31 INFO - PROCESS | 29504 | |3;mootools.html;1314.4216544720327;1451.1148199598244;1456.861598148176;1639.1476432255229;1825.6348730253953;7525.360344370728;7679.92320076799;7707.537547747139;7713.73001944932;7723.613819309026;7298.051253337072;7460.403167746581;7469.439792015593;7471.364933980604;7471.476996610239;2032.1668116072412;2208.3595757230382;2232.2745107839937;2260.3670972127748;2289.633658614622;2261.197274967388;2263.4001989472804;2270.2281224383705;2277.2598905355744;2278.5784629843447;2219.889005549716;2311.0640190722784;2313.560423519534;2314.3519814451897;2320.7563205863394;2260.0959616153505;2282.1327895399727;2282.942926426844;2297.3452566018773;2305.0664480885266;2151.429871084164;2162.156758864044;2166.620841352757;2168.642174041281;2254.3011666383472;7748.573828439434;7763.961180194119;7797.415193860483;7829.804254893616;7850.450468467209;4531.184386810372;4584.954150458486;4597.839075632371;4638.652101092398;4640.489546149921;2880.15035564509;3015.2160438285982;3017.788754787166;3073.55433462149;3077.092257783959;972.601233494264;979.5787811241163;984.9064338887795;988.8615593816871;1015.827309357411;10735.248532602722;10748.892511074868;10768.138548916068;10799.4060326682;10800.189985751022;4147.2534943710425;4267.359896015622;4341.5007274163245;4353.564643535621;4354.825806967686;9173.357864949523;9224.953875230582;9227.584758685874;9251.07489251083;9262.675806346746;4204.306289462204;4683.227267500893;4691.39011928454;4696.835610753676;4698.3187437821325;4171.624553790173;4198;4212.4523811904255;4225.429567008415;4245.80893859777;3727.2918145552258;3766.1714422826935;3806.562245341821;3833;3862.6909847212155;1196.3838623109107;1198.2510930668332;1201.7296108375544;1211.0493262788668;1224.5897624295783;1310.7050913544567;1322.4577923051502;1336.8863646590148;1356.6269275949194;1362.7274545091022;7315.085614298213;7476.140243871915;7567.962160189164;7576;7598.164201937893;1110.5557776889148;1115.4590023838432;1115.6206889657394;1121.9326840389604;1138.248755821154;5801.9419805802245;5816.82549523515;5865.794697185578;5866.12008198765;5867.325257595346;9111.772205694779;9441.622335106656;9656.565454554562;9663.710088697351;9772.9022709772;9548.61805527785;9632.566534505964;9637.469939153274;9667.27495437845;9729.221662267144;7288.161861386008;7369.336759691653;7588.772336829904;7648.273414025659;7681.116671582728;7313.963430182815;7342.926570734225;7342.9632851835395;7343.118825740731;7350.558966462029;8296.543690097102;8451.66193352259;8487.915120848713;8540.957295213484;8556.10160933093;8608.870866937126;8635.352348574008;8732.476051436934;8734.519601421729;8835.072317406837;5759.625624334405;6187.041008643668;6266.749330026931;6686.765963191265;6799.796006119825;7098.396636285974;7319;7347.926520734724;7368.115826100902;7376.520526165782;6564;6663.133792607124;6675.7997260082275;6770.458363330823;6788.626625535643;6340.809775706736;6505.577137486048;6574.737010519526;6599.703013364314;6659.2008958925235;6690.230623478167;6714.83212919681;6732.697028633625;6736.326367363225;6758.020087087443;6284.968575157095;6306.306306306395;6328.272248691275;6346.714397852015;6356.459700925473;6358.745650173942;6362.809115726535;6364.299927008118;6381.138546296376;6384.680765961776 16:15:31 INFO - PROCESS | 29504 | |4;prototype.html;337.09321924024385;338.3267298076826;339.8793428332942;342.7104097038003;346.2071855451017;5827.796027139051;5849.619774714652;5861.765529378825;5863.706814659271;5863.79476718315;5757.280339957505;5759.020966435705;5768.769249230037;5774.538036957044;5785.27684039495;4282.7858607069675;4368.890777730567;4450.176717307292;4499.325101234808;4533.2066888294585;4451.510333863289;4476.686631935766;4486.057927835142;4498.730076195438;4499.730016199022;4420.425344705184;4453.888652783674;4454.621357184643;4459.17505261526;4465.37484752135;4259.2546304396765;4377.934330985037;4455.933161002587;4496.3705081288645;4500.257457519506;3979.263836190314;3980.7412518186225;3988.900277493057;3991.9221810111108;3995.2409042281874;5471.015217260891;5475.835724928259;5485.314335708036;5487;5490.203920431555;5226.425093239741;5237.47625237477;5239.580833533309;5241;5248.0553500369915;6055.515558755289;6101.450869421773;6112.449879510821;6122.693865306717;6131.662758548278;4110.383442483621;4213.4522512073545;4218.7468751874985;4409.911801763947;4432.135733531963;6172.938270617281;6315.115883776275;6320.399562041599;6338;6362.013887847437;4310.956890431055;4316.028893498938;4320.265554855682;4320.524742278347;4324.589164029412;4353.498043175099;4368.213721530155;4368.825246990148;4370;4371.628411584988;5039.924401133986;5069.417017043087;5076.035553244872;5078.5937125029905;5081.7967281309075;5987.0121429963565;6122.938770612326;6138.202033735586;6139.938600613937;6142.907856382158;1538.946136885226;1557.6339560203344;1561.7423125184444;1561.9921900390425;1566.2560283865073;982.3320142303303;1011.2718842433436;1031.5718976624767;1065.9946700266448;1066.0405634928627;5761.193432919395;5763.3084029915835;5874.9118763218585;5876.353601103875;5889.676067816311;6231.626102433868;6260.718267677966;6320.241571011508;6322.841928951721;6329.2721337045905;5861.0915308127305;5866.973279676125;5873.676947767914;5873.853153671193;5874.823755287348;3325.783824051429;3359.8152101634646;3363.613184483767;3367.579052618423;3367.6295607483157;6368.140301059298;6604.702788374535;6609.504287178384;6631.303713110054;6636.767713130017;6375.171227740364;6402.9359706403275;6426.775062872777;6460.289368169498;6489.253735820441;6556.147700798961;6570.605763654196;6571.112899758567;6571.737130514822;6583.210014798159;6241.157443745036;6245.18812554365;6253.468455181361;6258.593191442542;6264.2796078451565;6029.4874935629205;6188.3502232266765;6194.442500175006;6194.783182588588;6196.10156527292;6562.081308616893;6567.770128045496;6582.407583317525;6593.835154121185;6594.868102637824;4361.149575832682;4383.079553293716;4384.342348647729;4384.364267181305;4388.84639037645;6175.011998080286;6260.937390626035;6307.526935479766;6320.273168585672;6332.0818481320875;6038.064100064497;6056.364081771527;6063.423974722395;6067.878642427215;6071.757129714939;5960.731767070579;6040.36576159497;6051.878962420815;6214.689265536615;6221.720022598904;6059.818205453844;6082.239720034996;6093.2078829751845;6103.572749907464;6106.45041946227;6197.25632924052;6226.40849119333;6238;6243.906341404791;6275.121482992294;5850.590458668023;5937.614055086406;6089.2997305310455;6095.451409373178;6097.420745029215 16:15:31 INFO - PROCESS | 29504 | |5;yui.html;737.6201256352979;743.0488974113138;745.9030326057612;760.9923900760992;762.1387831750123;12332.136750427462;12433.875661243384;12475.37623118845;12487.250764954098;12550.874491255085;12326.506939722423;13889.930550347259;14088.295585220749;14098.859011409882;14142.717145657081;682.15412888019;828.204923273658;840.029765620706;844.8141408890034;845.0155568762384;829.908710041898;840.277361469136;847.3052097280232;849.2059923971076;850.4557083466586;869.7260362985671;874.2001069021837;874.8775171475999;878.6880657366638;879.3141349747208;711.6833009310859;862.3446180902497;869.0961400143843;870.425519157353;873.5501216873315;630.3224034163293;631.0565704272096;631.8199313195763;632.2318383164431;634.0362648773838;12205.755884882252;12510.437030333565;12529.18560293578;12531.060170487159;12538.122331436804;12043.277403355827;12094.637160885188;12124.090693198046;12144.757104857854;12199.756004879942;9825.90174098257;9888;9948.552315145764;10054.145397641209;10158.492075396274;3479.982600087009;3510.9648903511147;3567.928641427157;3595.874144404959;3654.780713157219;49227;49492.25761613579;49528.257076143884;49556.50443495555;49644.50355496471;9865.556049977768;9911;10213.295502625691;10249.795004099877;10273.743156421;16798.244079016473;16802.747958780627;16843.74734378985;16861.072641004863;16878.915605421895;7592.696292148252;7599.202083781234;7738.110117336579;7858.1356050834365;7873;4208.431861698631;4241.785763978581;4327.6970612057485;4365.519792822787;4398.318260669601;3045.193023848682;3076.446239676835;3078.199668086269;3086.105029541453;3087.1818967973504;561.865152363438;565.5842955427757;566.1394680086246;572.6277919352455;573.8163787587932;624.1231070346171;657.4346062386344;660.8909529927508;666.1007639686482;690.7513295213719;7740.774976890576;7842.764717058498;7939.603019848984;8015.47899386538;8056.597170141469;586.8943590153814;601.4917394801386;627.8792355645152;635.8505751148476;670.4636290967206;3763.6800871926193;3897.590752970954;3942.2903877301787;3942.704297177723;3980.203959208112;54210.18684719732;55089.44910550924;55220.72389638107;55403;55490;46686;47525.28712069322;48165.5183448168;48233.5176648236;48465;43845.78077109594;44217.77891110524;44677;44710.77644611821;44835;7578.545287282781;7831.490953088031;7943.523388596703;8049.959750201446;8133.511989280662;33788.3242335147;33951.4907276396;33970.66029339774;34828;34889;39767.80116099401;40847;43095.35356969585;43265.56734432741;45984.31023534716;10584.717904475772;10664.093552048163;10754.89245107539;10872.695276566863;10923.781524369628;11675.532978680758;11816.231944923553;11902.821457678316;12084.274943503418;12426.130170888313;11003.449827508754;11193.216474847008;11358.886411135783;11388.316700997966;11588.884111159117;10143.64497242593;10417.322874013165;10543.525541350811;10712.73218169552;10813.945930270298;10909.34543927367;11004.39475828805;11016.779664406828;11363.147763917574;11445.599404020819;9361.297902657465;9491.66779162726;9497.525123743924;9634.855477167988;9833.754156146153;8349.106620816805;8564.503097225883;8732.34507411934;9038.051004644418;9301.860472092789 16:15:31 INFO - PROCESS | 29504 | __end_tp_report 16:15:31 INFO - PROCESS | 29504 | __start_cc_report 16:15:31 INFO - PROCESS | 29504 | _x_x_mozilla_cycle_collect,884 16:15:31 INFO - PROCESS | 29504 | __end_cc_report 16:15:31 INFO - PROCESS | 29504 | __startTimestamp1457136931946__endTimestamp 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | ------- Summary: start ------- 16:15:31 INFO - PROCESS | 29504 | Number of tests: 6 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#0] dojo.html Cycles:165 Average:5179.98 Median:5320.26 stddev:573.28 (10.8%) stddev-sans-first:550.95 16:15:31 INFO - PROCESS | 29504 | Values: 3083.9 3152.1 3197.6 3202.6 3228.6 5080.6 5144.8 5190.9 5196.5 5221.5 5206.9 5215.8 5217.5 5246.6 5280.7 4666.7 4716.3 4767.4 4825.2 4859.5 4679.7 4728.1 4802.7 4805.4 4918.0 4762.1 4772.0 4775.5 4805.3 4809.8 4772.4 4776.9 4778.0 4800.1 4827.5 4615.6 4654.0 4728.7 4760.2 4775.1 4986.6 4994.7 5006.5 5007.9 5043.7 5541.3 5548.8 5549.9 5554.3 5571.8 5427.9 5557.2 5606.2 5641.3 5699.6 5254.3 5263.7 5265.8 5273.6 5276.0 5591.3 5725.6 5727.1 5729.3 5731.3 5521.3 5552.3 5553.3 5568.0 5603.4 5497.8 5502.2 5502.8 5506.4 5507.1 5393.4 5472.8 5484.4 5486.7 5523.2 5585.9 5594.2 5594.9 5604.0 5629.6 4258.3 4263.2 4264.8 4272.7 4307.6 3747.2 3770.5 3801.5 3874.5 3889.2 5263.4 5281.8 5285.0 5297.4 5320.3 5572.4 5588.1 5591.4 5597.6 5609.1 5155.4 5220.1 5270.2 5300.1 5304.6 4763.4 4768.5 4776.3 4786.2 4824.9 5905.2 5924.1 5928.0 5930.9 5931.1 5412.1 5431.5 5432.0 5507.6 5508.8 5909.4 5913.6 5923.9 5929.0 5930.2 5283.4 5556.0 5560.5 5567.3 5571.4 5583.5 5601.4 5606.8 5611.4 5663.7 5430.3 5440.5 5441.4 5444.7 5445.3 5326.1 5412.4 5440.9 5445.2 5493.9 5280.4 5287.8 5293.7 5295.1 5328.9 5361.6 5363.7 5393.0 5404.3 5413.5 5153.3 5305.5 5315.7 5350.0 5373.6 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#1] ext.html Cycles:180 Average:41554.74 Median:34768.74 stddev:63492.60 (182.6%) stddev-sans-first:63595.96 16:15:31 INFO - PROCESS | 29504 | Values: 520.6 529.1 540.7 549.9 592.2 35130.5 35752.1 35815.6 35892.6 35920.6 39877.2 40238.0 40387.0 40412.4 40482.4 8432.8 8687.3 8697.0 8704.3 8709.1 8543.1 8684.0 8684.8 8928.2 8935.2 8777.3 8792.9 8826.7 8851.9 8854.0 8845.2 8918.0 8926.7 8933.2 8933.4 8769.6 8899.3 8903.0 8912.6 8913.3 40548.0 40900.2 40989.4 41028.2 41089.8 3112.6 3129.8 3318.1 3421.8 3716.7 29725.0 30369.0 30554.4 30634.1 30807.0 3354.6 3380.4 3390.7 3431.1 3469.1 253900.0 254806.0 255511.0 256352.0 256695.0 58239.4 58254.0 58490.7 58670.4 58685.7 61830.4 65812.7 67321.3 67389.3 67391.0 15519.9 15704.2 15711.3 15714.4 15722.1 11876.4 11916.6 11929.8 11932.9 11939.0 20709.8 21049.5 21225.9 21250.0 21261.6 7661.7 7788.8 7804.0 7867.3 7886.8 858.5 909.2 910.6 964.0 1006.7 28029.2 28221.4 28517.1 28533.3 28719.6 917.4 952.4 999.9 1003.4 1077.2 14869.8 15018.2 15132.2 15211.5 15254.7 282198.0 283324.0 283924.0 286532.0 287906.0 49884.5 50381.7 50431.7 50446.0 50455.7 1167.1 1170.3 1206.6 1234.1 1354.3 26495.5 28305.6 28314.2 28396.6 28864.6 39303.2 39401.6 39534.2 39731.8 39962.4 171599.0 176610.0 179294.0 180927.0 181447.0 27070.0 30184.8 30504.5 30901.5 31896.5 40089.2 40545.6 40940.8 41407.2 41548.4 33614.8 34400.5 34617.0 35092.8 35260.5 32967.0 34347.5 34592.3 34764.5 34797.8 33438.5 33951.7 34186.7 34513.1 34773.0 31811.5 34679.7 34680.7 34828.8 35102.1 23994.4 25364.7 25422.6 25813.9 25944.4 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#2] jquery.html Cycles:180 Average:24438.40 Median:5326.38 stddev:70010.65 (1314.4%) stddev-sans-first:70183.68 16:15:31 INFO - PROCESS | 29504 | Values: 348.2 352.3 356.9 357.1 358.5 16470.4 16633.8 17714.9 17816.3 17937.9 16284.3 16532.5 16802.7 16817.5 16821.1 5192.9 5255.1 5480.4 5501.1 5507.7 5395.8 5449.1 5449.5 5451.7 5493.9 5423.9 5431.0 5516.2 5683.5 5754.8 5615.2 5668.7 5670.1 5706.7 5730.3 5290.1 5309.8 5312.5 5323.0 5329.8 11651.0 11729.0 11833.7 12298.7 12777.2 1920.2 2037.6 2059.5 2685.4 2705.1 9195.3 9255.9 9306.5 9358.6 9501.7 1750.1 1791.9 1792.4 1820.9 1891.4 57537.1 59541.4 60192.0 62156.0 63969.4 9812.9 9936.2 10095.2 10191.2 10194.3 13258.0 13363.8 13373.0 13373.5 13374.5 7170.4 7270.8 7419.8 7536.3 7540.7 7044.0 7067.4 7102.2 7167.6 7245.7 4427.9 4439.3 4449.7 4458.5 4525.0 1812.6 1825.6 1828.5 1844.6 1851.1 870.2 875.9 876.2 956.5 960.9 13813.7 13869.5 16027.8 16516.3 16537.8 825.0 831.1 860.2 892.5 924.7 8901.2 9005.4 9177.5 9220.9 9336.9 419731.0 422450.0 424366.0 425465.0 437932.0 74884.6 75720.0 77120.0 78188.0 78603.0 1047.2 1050.1 1070.3 1074.4 1074.7 13749.4 14121.6 14223.5 14474.9 14515.8 24939.4 30512.2 32818.3 33045.8 33658.8 45446.0 49764.0 49837.0 50057.0 50064.2 7154.5 7159.5 7280.2 7376.3 7397.9 8761.4 10984.8 10999.1 11046.4 11232.4 9614.2 9655.8 9656.1 9711.6 9955.1 7631.3 7877.1 9787.2 9821.0 10054.7 9680.3 9729.9 9738.5 10059.3 10098.5 7045.9 7103.9 7138.9 7188.2 7416.4 9415.0 9497.7 9620.5 9632.7 9798.4 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#3] mootools.html Cycles:180 Average:5435.57 Median:6317.29 stddev:2830.69 (44.8%) stddev-sans-first:2821.68 16:15:31 INFO - PROCESS | 29504 | Values: 1314.4 1451.1 1456.9 1639.1 1825.6 7525.4 7679.9 7707.5 7713.7 7723.6 7298.1 7460.4 7469.4 7471.4 7471.5 2032.2 2208.4 2232.3 2260.4 2289.6 2261.2 2263.4 2270.2 2277.3 2278.6 2219.9 2311.1 2313.6 2314.4 2320.8 2260.1 2282.1 2282.9 2297.3 2305.1 2151.4 2162.2 2166.6 2168.6 2254.3 7748.6 7764.0 7797.4 7829.8 7850.5 4531.2 4585.0 4597.8 4638.7 4640.5 2880.2 3015.2 3017.8 3073.6 3077.1 972.6 979.6 984.9 988.9 1015.8 10735.2 10748.9 10768.1 10799.4 10800.2 4147.3 4267.4 4341.5 4353.6 4354.8 9173.4 9225.0 9227.6 9251.1 9262.7 4204.3 4683.2 4691.4 4696.8 4698.3 4171.6 4198.0 4212.5 4225.4 4245.8 3727.3 3766.2 3806.6 3833.0 3862.7 1196.4 1198.3 1201.7 1211.0 1224.6 1310.7 1322.5 1336.9 1356.6 1362.7 7315.1 7476.1 7568.0 7576.0 7598.2 1110.6 1115.5 1115.6 1121.9 1138.2 5801.9 5816.8 5865.8 5866.1 5867.3 9111.8 9441.6 9656.6 9663.7 9772.9 9548.6 9632.6 9637.5 9667.3 9729.2 7288.2 7369.3 7588.8 7648.3 7681.1 7314.0 7342.9 7343.0 7343.1 7350.6 8296.5 8451.7 8487.9 8541.0 8556.1 8608.9 8635.4 8732.5 8734.5 8835.1 5759.6 6187.0 6266.7 6686.8 6799.8 7098.4 7319.0 7347.9 7368.1 7376.5 6564.0 6663.1 6675.8 6770.5 6788.6 6340.8 6505.6 6574.7 6599.7 6659.2 6690.2 6714.8 6732.7 6736.3 6758.0 6285.0 6306.3 6328.3 6346.7 6356.5 6358.7 6362.8 6364.3 6381.1 6384.7 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#4] prototype.html Cycles:180 Average:5129.31 Median:5862.74 stddev:1536.39 (26.2%) stddev-sans-first:1498.01 16:15:31 INFO - PROCESS | 29504 | Values: 337.1 338.3 339.9 342.7 346.2 5827.8 5849.6 5861.8 5863.7 5863.8 5757.3 5759.0 5768.8 5774.5 5785.3 4282.8 4368.9 4450.2 4499.3 4533.2 4451.5 4476.7 4486.1 4498.7 4499.7 4420.4 4453.9 4454.6 4459.2 4465.4 4259.3 4377.9 4455.9 4496.4 4500.3 3979.3 3980.7 3988.9 3991.9 3995.2 5471.0 5475.8 5485.3 5487.0 5490.2 5226.4 5237.5 5239.6 5241.0 5248.1 6055.5 6101.5 6112.4 6122.7 6131.7 4110.4 4213.5 4218.7 4409.9 4432.1 6172.9 6315.1 6320.4 6338.0 6362.0 4311.0 4316.0 4320.3 4320.5 4324.6 4353.5 4368.2 4368.8 4370.0 4371.6 5039.9 5069.4 5076.0 5078.6 5081.8 5987.0 6122.9 6138.2 6139.9 6142.9 1538.9 1557.6 1561.7 1562.0 1566.3 982.3 1011.3 1031.6 1066.0 1066.0 5761.2 5763.3 5874.9 5876.4 5889.7 6231.6 6260.7 6320.2 6322.8 6329.3 5861.1 5867.0 5873.7 5873.9 5874.8 3325.8 3359.8 3363.6 3367.6 3367.6 6368.1 6604.7 6609.5 6631.3 6636.8 6375.2 6402.9 6426.8 6460.3 6489.3 6556.1 6570.6 6571.1 6571.7 6583.2 6241.2 6245.2 6253.5 6258.6 6264.3 6029.5 6188.4 6194.4 6194.8 6196.1 6562.1 6567.8 6582.4 6593.8 6594.9 4361.1 4383.1 4384.3 4384.4 4388.8 6175.0 6260.9 6307.5 6320.3 6332.1 6038.1 6056.4 6063.4 6067.9 6071.8 5960.7 6040.4 6051.9 6214.7 6221.7 6059.8 6082.2 6093.2 6103.6 6106.5 6197.3 6226.4 6238.0 6243.9 6275.1 5850.6 5937.6 6089.3 6095.5 6097.4 16:15:31 INFO - PROCESS | 29504 | 16:15:31 INFO - PROCESS | 29504 | [#5] yui.html Cycles:180 Average:13346.56 Median:47105.64 stddev:15406.05 (32.7%) stddev-sans-first:15420.17 16:15:31 INFO - PROCESS | 29504 | Values: 737.6 743.0 745.9 761.0 762.1 12332.1 12433.9 12475.4 12487.3 12550.9 12326.5 13889.9 14088.3 14098.9 14142.7 682.2 828.2 840.0 844.8 845.0 829.9 840.3 847.3 849.2 850.5 869.7 874.2 874.9 878.7 879.3 711.7 862.3 869.1 870.4 873.6 630.3 631.1 631.8 632.2 634.0 12205.8 12510.4 12529.2 12531.1 12538.1 12043.3 12094.6 12124.1 12144.8 12199.8 9825.9 9888.0 9948.6 10054.1 10158.5 3480.0 3511.0 3567.9 3595.9 3654.8 49227.0 49492.3 49528.3 49556.5 49644.5 9865.6 9911.0 10213.3 10249.8 10273.7 16798.2 16802.7 16843.7 16861.1 16878.9 7592.7 7599.2 7738.1 7858.1 7873.0 4208.4 4241.8 4327.7 4365.5 4398.3 3045.2 3076.4 3078.2 3086.1 3087.2 561.9 565.6 566.1 572.6 573.8 624.1 657.4 660.9 666.1 690.8 7740.8 7842.8 7939.6 8015.5 8056.6 586.9 601.5 627.9 635.9 670.5 3763.7 3897.6 3942.3 3942.7 3980.2 54210.2 55089.4 55220.7 55403.0 55490.0 46686.0 47525.3 48165.5 48233.5 48465.0 43845.8 44217.8 44677.0 44710.8 44835.0 7578.5 7831.5 7943.5 8050.0 8133.5 33788.3 33951.5 33970.7 34828.0 34889.0 39767.8 40847.0 43095.4 43265.6 45984.3 10584.7 10664.1 10754.9 10872.7 10923.8 11675.5 11816.2 11902.8 12084.3 12426.1 11003.4 11193.2 11358.9 11388.3 11588.9 10143.6 10417.3 10543.5 10712.7 10813.9 10909.3 11004.4 11016.8 11363.1 11445.6 9361.3 9491.7 9497.5 9634.9 9833.8 8349.1 8564.5 8732.3 9038.1 9301.9 16:15:31 INFO - PROCESS | 29504 | -------- Summary: end -------- 16:15:31 INFO - PROCESS | 29504 | 16:15:32 INFO - TEST-INFO | 29504: exit 0 16:15:32 INFO - TEST-OK | dromaeo_css | took 1112717ms 16:15:32 INFO - TEST-START | kraken 16:15:32 INFO - operating with platform_type : linux_ 16:15:32 INFO - Initialising browser for kraken test... 16:15:32 INFO - TEST-INFO | started process 29692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2PCx76/profile http://localhost:44987/getInfo.html) 16:15:36 INFO - PROCESS | 29692 | __metrics Screen width/height:1600/1200 16:15:36 INFO - PROCESS | 29692 | colorDepth:24 16:15:36 INFO - PROCESS | 29692 | Browser inner width/height: 1024/697 16:15:36 INFO - PROCESS | 29692 | __metrics 16:15:37 INFO - PROCESS | 29692 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:37 INFO - PROCESS | 29692 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:15:38 INFO - TEST-INFO | 29692: exit 0 16:15:38 INFO - Browser initialized. 16:15:38 INFO - Running cycle 1/1 for kraken test... 16:15:38 INFO - TEST-INFO | started process 29775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2PCx76/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:50 INFO - PROCESS | 29775 | RSS: Main: 153931776 16:15:50 INFO - PROCESS | 29775 | 16:15:52 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44987/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:53 INFO - PROCESS | 29775 | RSS: Main: 197369856 16:15:53 INFO - PROCESS | 29775 | 16:15:55 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44987/tests/kraken/driver.html?testName=audio-dft) 16:15:56 INFO - PROCESS | 29775 | RSS: Main: 185446400 16:15:56 INFO - PROCESS | 29775 | 16:15:59 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44987/tests/kraken/driver.html?testName=audio-fft) 16:16:00 INFO - PROCESS | 29775 | RSS: Main: 171716608 16:16:00 INFO - PROCESS | 29775 | 16:16:02 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44987/tests/kraken/driver.html?testName=audio-oscillator) 16:16:02 INFO - PROCESS | 29775 | RSS: Main: 173125632 16:16:02 INFO - PROCESS | 29775 | 16:16:04 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:05 INFO - PROCESS | 29775 | RSS: Main: 175390720 16:16:05 INFO - PROCESS | 29775 | 16:16:08 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44987/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:09 INFO - PROCESS | 29775 | RSS: Main: 175837184 16:16:09 INFO - PROCESS | 29775 | 16:16:12 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44987/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:13 INFO - PROCESS | 29775 | RSS: Main: 175939584 16:16:13 INFO - PROCESS | 29775 | 16:16:15 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44987/tests/kraken/driver.html?testName=json-parse-financial) 16:16:16 INFO - PROCESS | 29775 | RSS: Main: 175079424 16:16:16 INFO - PROCESS | 29775 | 16:16:17 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:18 INFO - PROCESS | 29775 | RSS: Main: 187564032 16:16:18 INFO - PROCESS | 29775 | 16:16:20 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:20 INFO - PROCESS | 29775 | RSS: Main: 185917440 16:16:20 INFO - PROCESS | 29775 | 16:16:22 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:23 INFO - PROCESS | 29775 | RSS: Main: 197713920 16:16:23 INFO - PROCESS | 29775 | 16:16:25 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:26 INFO - PROCESS | 29775 | RSS: Main: 202391552 16:16:26 INFO - PROCESS | 29775 | 16:16:29 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:29 INFO - PROCESS | 29775 | RSS: Main: 202956800 16:16:29 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | Cycle 1(1): loaded http://localhost:44987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44987/tests/kraken/driver.html?testName=ai-astar) 16:16:31 INFO - PROCESS | 29775 | RSS: Main: 263954432 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | __start_tp_report 16:16:31 INFO - PROCESS | 29775 | _x_x_mozilla_page_load 16:16:31 INFO - PROCESS | 29775 | _x_x_mozilla_page_load_details 16:16:31 INFO - PROCESS | 29775 | |i|pagename|runs| 16:16:31 INFO - PROCESS | 29775 | |0;ai-astar;112;111;106;111;113;111;99;110;111;111 16:16:31 INFO - PROCESS | 29775 | |1;audio-beat-detection;160;128;156;172;128;149;157;130;169;140 16:16:31 INFO - PROCESS | 29775 | |2;audio-dft;162;160;160;160;159;160;163;163;162;161 16:16:31 INFO - PROCESS | 29775 | |3;audio-fft;72;76;99;110;76;75;73;131;103;71 16:16:31 INFO - PROCESS | 29775 | |4;audio-oscillator;93;93;150;94;94;94;148;94;94;146 16:16:31 INFO - PROCESS | 29775 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;118;117;117 16:16:31 INFO - PROCESS | 29775 | |6;imaging-darkroom;148;147;146;146;147;146;145;145;146;146 16:16:31 INFO - PROCESS | 29775 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;96 16:16:31 INFO - PROCESS | 29775 | |8;json-parse-financial;59;56;60;57;57;57;60;66;56;57 16:16:31 INFO - PROCESS | 29775 | |9;json-stringify-tinderbox;66;66;67;66;67;66;66;67;68;66 16:16:31 INFO - PROCESS | 29775 | |10;stanford-crypto-aes;82;80;83;91;82;81;82;81;90;82 16:16:31 INFO - PROCESS | 29775 | |11;stanford-crypto-ccm;118;117;118;121;115;112;118;117;117;114 16:16:31 INFO - PROCESS | 29775 | |12;stanford-crypto-pbkdf2;158;148;162;152;150;142;159;144;151;151 16:16:31 INFO - PROCESS | 29775 | |13;stanford-crypto-sha256-iterative;69;69;72;70;68;69;67;69;67;69 16:16:31 INFO - PROCESS | 29775 | __end_tp_report 16:16:31 INFO - PROCESS | 29775 | __start_cc_report 16:16:31 INFO - PROCESS | 29775 | _x_x_mozilla_cycle_collect,1101 16:16:31 INFO - PROCESS | 29775 | __end_cc_report 16:16:31 INFO - PROCESS | 29775 | __startTimestamp1457136991676__endTimestamp 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | ------- Summary: start ------- 16:16:31 INFO - PROCESS | 29775 | Number of tests: 14 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.27 16:16:31 INFO - PROCESS | 29775 | Values: 112.0 111.0 106.0 111.0 113.0 111.0 99.0 110.0 111.0 111.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.50 stddev:16.62 (10.6%) stddev-sans-first:17.14 16:16:31 INFO - PROCESS | 29775 | Values: 160.0 128.0 156.0 172.0 128.0 149.0 157.0 130.0 169.0 140.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 16:16:31 INFO - PROCESS | 29775 | Values: 162.0 160.0 160.0 160.0 159.0 160.0 163.0 163.0 162.0 161.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#3] audio-fft Cycles:10 Average:88.60 Median:74.00 stddev:20.82 (28.1%) stddev-sans-first:21.20 16:16:31 INFO - PROCESS | 29775 | Values: 72.0 76.0 99.0 110.0 76.0 75.0 73.0 131.0 103.0 71.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.00 stddev:26.24 (27.9%) stddev-sans-first:27.10 16:16:31 INFO - PROCESS | 29775 | Values: 93.0 93.0 150.0 94.0 94.0 94.0 148.0 94.0 94.0 146.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 16:16:31 INFO - PROCESS | 29775 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 16:16:31 INFO - PROCESS | 29775 | Values: 148.0 147.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 146.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:16:31 INFO - PROCESS | 29775 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:3.03 (5.2%) stddev-sans-first:3.21 16:16:31 INFO - PROCESS | 29775 | Values: 59.0 56.0 60.0 57.0 57.0 57.0 60.0 66.0 56.0 57.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 16:16:31 INFO - PROCESS | 29775 | Values: 66.0 66.0 67.0 66.0 67.0 66.0 66.0 67.0 68.0 66.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.00 stddev:3.84 (4.7%) stddev-sans-first:4.03 16:16:31 INFO - PROCESS | 29775 | Values: 82.0 80.0 83.0 91.0 82.0 81.0 82.0 81.0 90.0 82.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.50 stddev:2.50 (2.1%) stddev-sans-first:2.60 16:16:31 INFO - PROCESS | 29775 | Values: 118.0 117.0 118.0 121.0 115.0 112.0 118.0 117.0 117.0 114.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:151.50 stddev:6.41 (4.2%) stddev-sans-first:6.38 16:16:31 INFO - PROCESS | 29775 | Values: 158.0 148.0 162.0 152.0 150.0 142.0 159.0 144.0 151.0 151.0 16:16:31 INFO - PROCESS | 29775 | 16:16:31 INFO - PROCESS | 29775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 16:16:31 INFO - PROCESS | 29775 | Values: 69.0 69.0 72.0 70.0 68.0 69.0 67.0 69.0 67.0 69.0 16:16:31 INFO - PROCESS | 29775 | -------- Summary: end -------- 16:16:31 INFO - PROCESS | 29775 | 16:16:32 INFO - TEST-INFO | 29775: exit 0 16:16:32 INFO - TEST-OK | kraken | took 59839ms 16:16:32 INFO - SUITE-END | took 1172s 16:16:32 INFO - Completed test suite (00:19:32) 16:16:32 INFO - javascript benchmark 16:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3083.8920637777674, 3152.0701393089034, 3197.6482586915436, 3202.5836641236638, 3228.5641438405814, 5080.618953578478, 5144.845654630362, 5190.948090519094, 5196.532312091911, 5221.451747566508, 5206.8698282542955, 5215.765290561924, 5217.530422261995, 5246.632735708502, 5280.683159010462, 4666.673332866701, 4716.339712440253, 4767.356406885061, 4825.155597770394, 4859.538343857328, 4679.695819771704, 4728.148933192024, 4802.663813533054, 4805.351277577534, 4918.0, 4762.1428142934255, 4771.9522804772205, 4775.522447755214, 4805.327254184417, 4809.807607695688, 4772.379590653228, 4776.8566942991765, 4778.0205057963385, 4800.135975524404, 4827.51724827518, 4615.630749540029, 4653.953460465385, 4728.739919304471, 4760.238361862085, 4775.068861571995, 4986.601071914238, 4994.700317980896, 5006.524380183877, 5007.949920500785, 5043.722595257259, 5541.251930989305, 5548.77804887804, 5549.889002219973, 5554.305711786027, 5571.832845014656, 5427.864303392407, 5557.166425036236, 5606.21512988182, 5641.323041235037, 5699.57253206007, 5254.290670759437, 5263.6841789492755, 5265.815696450644, 5273.630845840793, 5276.023935571931, 5591.30108736408, 5725.627834190847, 5727.140928860705, 5729.255196824386, 5731.283589551306, 5521.337439507285, 5552.250446189793, 5553.250311208016, 5567.972160139173, 5603.411641777555, 5497.752601132958, 5502.174673798882, 5502.779888804403, 5506.421825708323, 5507.091329930597, 5393.406725260218, 5472.799856998175, 5484.396716361197, 5486.725663716798, 5523.199136125239, 5585.916211256835, 5594.24477695514, 5594.916076258859, 5604.047311956977, 5629.634073785191, 4258.318669012943, 4263.16868210696, 4264.7654379009455, 4272.658187345005, 4307.569243075667, 3747.213085252073, 3770.453284273765, 3801.5438147422487, 3874.535055793323, 3889.1638297766117, 5263.421023687468, 5281.841544753664, 5284.9735751320995, 5297.390800058042, 5320.255164277004, 5572.3870374258795, 5588.077967135378, 5591.440855914376, 5597.608167428241, 5609.074502707089, 5155.355580552431, 5220.086484865209, 5270.235815806764, 5300.1254792958725, 5304.602154838402, 4763.404574428197, 4768.499307572724, 4776.283557466408, 4786.16242157621, 4824.855254342376, 5905.173275741399, 5924.081767326072, 5928.0, 5930.9406905931255, 5931.139984702194, 5412.079946409041, 5431.538319242909, 5432.0, 5507.614466987273, 5508.779648814003, 5909.438603332676, 5913.5564832636865, 5923.881522369615, 5929.0, 5930.199423077829, 5283.418823929288, 5555.972220138873, 5560.499555040065, 5567.331920169444, 5571.3592936811165, 5583.469570390806, 5601.355844077983, 5606.831795045992, 5611.354694210218, 5663.716814159193, 5430.294061771944, 5440.483154100354, 5441.401445841034, 5444.673319600836, 5445.264889239902, 5326.0945639240645, 5412.350517937873, 5440.8639784004135, 5445.183222516495, 5493.890122197614, 5280.3663560373, 5287.788488460573, 5293.708846013506, 5295.099833028471, 5328.8934221314585, 5361.624686271924, 5363.714120899775, 5392.973035134799, 5404.297441332602, 5413.485718856702, 5153.330067091254, 5305.495977882095, 5315.681059136464, 5350.0, 5373.570114390917], "unit": "score", "name": "dojo.html", "value": 5143.299314135853}, {"lowerIsBetter": false, "replicates": [520.5705293133163, 529.0529951387017, 540.6972095626451, 549.8872731090125, 592.1502643706284, 35130.47304290435, 35752.10619734508, 35815.64184358156, 35892.64107358926, 35920.64079359206, 39877.202455950865, 40238.0, 40387.0, 40412.39381409274, 40482.39276410856, 8432.83134337313, 8687.30501559877, 8696.956515217415, 8704.347173961947, 8709.085546017672, 8543.102974187714, 8684.0, 8684.826303473927, 8928.241099506517, 8935.240504557089, 8777.253933415668, 8792.912070879305, 8826.735197944072, 8851.911480885205, 8854.02605713371, 8845.248153906894, 8918.0, 8926.73219803407, 8933.240674542672, 8933.374663773538, 8769.605367758402, 8899.288056955427, 8902.955485222597, 8912.55437228136, 8913.28693704502, 40548.0, 40900.1819963602, 40989.385159222635, 41028.179436411105, 41089.79455102735, 3112.59536260287, 3129.8435078246225, 3318.0875259303643, 3421.8460169292193, 3716.721245906541, 29725.027497250318, 30369.0, 30554.38891222163, 30634.084012138796, 30807.0, 3354.563906692139, 3380.3915295246848, 3390.6948374646154, 3431.0555793201447, 3469.0633528947296, 253900.0, 254805.99999999814, 255511.0, 256352.0, 256695.0, 58239.4176058234, 58254.0, 58490.70754646199, 58670.41329586735, 58685.70657146687, 61830.381696183365, 65812.67093664501, 67321.32678673249, 67389.32610673929, 67390.989135163, 15519.922400387926, 15704.214789260719, 15711.292991815395, 15714.371425142866, 15722.13528255957, 11876.406179690981, 11916.582919597773, 11929.761404771856, 11932.880671193177, 11939.0, 20709.792902071087, 21049.473763156042, 21225.893870530857, 21250.0, 21261.57476850485, 7661.693532258759, 7788.805279868048, 7803.960980195063, 7867.291943725092, 7886.802829929297, 858.5406807358033, 909.1771946388529, 910.6084383714933, 963.9710808675751, 1006.7483129217695, 28029.159125226277, 28221.43557128846, 28517.144485665463, 28533.28666783347, 28719.56920646192, 917.4449458077901, 952.4142652268805, 999.8900120986685, 1003.4481035430484, 1077.2028698763015, 14869.776953345709, 15018.174000429863, 15132.167730774692, 15211.467598634215, 15254.694906102039, 282198.0, 283324.0, 283924.0, 286532.0, 287906.0, 49884.50115498871, 50381.748091260044, 50431.747841260556, 50446.0, 50455.74772126189, 1167.0896700573567, 1170.3329102411544, 1206.6440400081997, 1234.111439763369, 1354.3499120422055, 26495.482929121703, 28305.57541636918, 28314.150575482767, 28396.574051388834, 28864.567031494124, 39303.21393572055, 39401.60598393979, 39534.20931581295, 39731.80134099311, 39962.40056399098, 171599.0, 176610.0, 179294.0, 180927.0, 181447.0, 27070.0, 30184.849075754482, 30504.542431863098, 30901.536476952413, 31896.521552176273, 40089.1982160361, 40545.594544054184, 40940.79529602333, 41407.171856563305, 41548.3767743478, 33614.83192584021, 34400.48399274063, 34617.0, 35092.82453587716, 35260.47109293414, 32967.0, 34347.4847877287, 34592.270386481076, 34764.47853282253, 34797.82601086979, 33438.49842252417, 33951.66048339485, 34186.65813341934, 34513.13717157091, 34773.0, 31811.522827157147, 34679.65320346764, 34680.65319346875, 34828.82585587056, 35102.12244693903, 23994.40013999664, 25364.746352536975, 25422.618660719734, 25813.870930645226, 25944.351391215372], "unit": "score", "name": "ext.html", "value": 17812.345957164805}, {"lowerIsBetter": false, "replicates": [348.23214811340995, 352.32881361007276, 356.88936429706774, 357.13395017083576, 358.541067433685, 16470.423535176273, 16633.750493742602, 17714.91142544287, 17816.287348506045, 17937.910310448464, 16284.26720797567, 16532.504024879243, 16802.747958780597, 16817.495475135765, 16821.074840883746, 5192.88353004104, 5255.0803609368395, 5480.424555421683, 5501.092319767234, 5507.697076660782, 5395.78416863325, 5449.128139497681, 5449.509544141027, 5451.672899626015, 5493.890122197554, 5423.918641220384, 5431.0, 5516.172574113895, 5683.5169010634145, 5754.827355179351, 5615.157726341041, 5668.68822214778, 5670.064439367499, 5706.743196556165, 5730.283714535683, 5290.127129023706, 5309.840704778863, 5312.5218730314455, 5323.0, 5329.7601607927345, 11651.0, 11729.0, 11833.704157396134, 12298.692532686666, 12777.169483983604, 1920.1839218332293, 2037.6128535578341, 2059.5366042640435, 2685.449269611365, 2705.066751970567, 9195.310351723647, 9255.861162082507, 9306.53467326631, 9358.57886395114, 9501.714948551555, 1750.0724615953566, 1791.8779456973584, 1792.363710882644, 1820.8816426932208, 1891.4042076745782, 57537.13694294589, 59541.40458595402, 60192.0, 62156.0, 63969.36030639727, 9812.901870981199, 9936.205103591696, 10095.24285678577, 10191.184705223564, 10194.286399951932, 13258.0, 13363.797258246805, 13373.0, 13373.53192638253, 13374.531891383755, 7170.39051680613, 7270.8182295441975, 7419.8145046374275, 7536.284053014955, 7540.736074237376, 7043.9786230996215, 7067.363937245673, 7102.218755936843, 7167.641617919187, 7245.746398876119, 4427.911441771146, 4439.311906654474, 4449.688521803508, 4458.464984201916, 4525.0497395546645, 1812.56498440376, 1825.616620509708, 1828.506303298102, 1844.5665268661853, 1851.1022154255174, 870.2254993056185, 875.9124087591317, 876.2157868707471, 956.4882787708682, 960.9135177833889, 13813.723725525433, 13869.514566990309, 16027.759583606256, 16516.339346426248, 16537.751933721003, 824.9752507424787, 831.0775039705921, 860.2086080805674, 892.5180402582532, 924.6994726713845, 8901.154390332907, 9005.369624126248, 9177.495237761854, 9220.90779092214, 9336.906630933603, 419731.0, 422450.0, 424366.0, 425465.0, 437932.0, 74884.62557687177, 75720.0, 77120.0, 78188.0, 78603.0, 1047.198892846988, 1050.0864248104199, 1070.2882583082164, 1074.435921141407, 1074.7098283463422, 13749.381277842322, 14121.576352709435, 14223.502177423741, 14474.927625361806, 14515.782263265848, 24939.376515587257, 30512.23719406944, 32818.34363312673, 33045.83477082599, 33658.831705841316, 45446.0, 49764.033035374356, 49837.0, 50057.0, 50064.24903626522, 7154.534955227893, 7159.498835081495, 7280.1991780903, 7376.336129748348, 7397.927300541499, 8761.430507017278, 10984.835227471434, 10999.120070394509, 11046.392448415414, 11232.438378081226, 9614.230861531201, 9655.806883862424, 9656.130948214695, 9711.611535538783, 9955.104040636377, 7631.275028872248, 7877.054753429625, 9787.16809071237, 9820.950895245478, 10054.748631284276, 9680.322377433513, 9729.929707732286, 9738.464384458639, 10059.295849290773, 10098.495075246356, 7045.894311585228, 7103.9289607103265, 7138.892916606359, 7188.209296977433, 7416.406687465098, 9415.0, 9497.715068547956, 9620.470874101991, 9632.711018669452, 9798.412095274307], "unit": "score", "name": "jquery.html", "value": 7992.837326069124}, {"lowerIsBetter": false, "replicates": [1314.4216544720327, 1451.1148199598244, 1456.861598148176, 1639.1476432255229, 1825.6348730253953, 7525.360344370728, 7679.92320076799, 7707.537547747139, 7713.73001944932, 7723.613819309026, 7298.051253337072, 7460.403167746581, 7469.439792015593, 7471.364933980604, 7471.476996610239, 2032.1668116072412, 2208.3595757230382, 2232.2745107839937, 2260.3670972127748, 2289.633658614622, 2261.197274967388, 2263.4001989472804, 2270.2281224383705, 2277.2598905355744, 2278.5784629843447, 2219.889005549716, 2311.0640190722784, 2313.560423519534, 2314.3519814451897, 2320.7563205863394, 2260.0959616153505, 2282.1327895399727, 2282.942926426844, 2297.3452566018773, 2305.0664480885266, 2151.429871084164, 2162.156758864044, 2166.620841352757, 2168.642174041281, 2254.3011666383472, 7748.573828439434, 7763.961180194119, 7797.415193860483, 7829.804254893616, 7850.450468467209, 4531.184386810372, 4584.954150458486, 4597.839075632371, 4638.652101092398, 4640.489546149921, 2880.15035564509, 3015.2160438285982, 3017.788754787166, 3073.55433462149, 3077.092257783959, 972.601233494264, 979.5787811241163, 984.9064338887795, 988.8615593816871, 1015.827309357411, 10735.248532602722, 10748.892511074868, 10768.138548916068, 10799.4060326682, 10800.189985751022, 4147.2534943710425, 4267.359896015622, 4341.5007274163245, 4353.564643535621, 4354.825806967686, 9173.357864949523, 9224.953875230582, 9227.584758685874, 9251.07489251083, 9262.675806346746, 4204.306289462204, 4683.227267500893, 4691.39011928454, 4696.835610753676, 4698.3187437821325, 4171.624553790173, 4198.0, 4212.4523811904255, 4225.429567008415, 4245.80893859777, 3727.2918145552258, 3766.1714422826935, 3806.562245341821, 3833.0, 3862.6909847212155, 1196.3838623109107, 1198.2510930668332, 1201.7296108375544, 1211.0493262788668, 1224.5897624295783, 1310.7050913544567, 1322.4577923051502, 1336.8863646590148, 1356.6269275949194, 1362.7274545091022, 7315.085614298213, 7476.140243871915, 7567.962160189164, 7576.0, 7598.164201937893, 1110.5557776889148, 1115.4590023838432, 1115.6206889657394, 1121.9326840389604, 1138.248755821154, 5801.9419805802245, 5816.82549523515, 5865.794697185578, 5866.12008198765, 5867.325257595346, 9111.772205694779, 9441.622335106656, 9656.565454554562, 9663.710088697351, 9772.9022709772, 9548.61805527785, 9632.566534505964, 9637.469939153274, 9667.27495437845, 9729.221662267144, 7288.161861386008, 7369.336759691653, 7588.772336829904, 7648.273414025659, 7681.116671582728, 7313.963430182815, 7342.926570734225, 7342.9632851835395, 7343.118825740731, 7350.558966462029, 8296.543690097102, 8451.66193352259, 8487.915120848713, 8540.957295213484, 8556.10160933093, 8608.870866937126, 8635.352348574008, 8732.476051436934, 8734.519601421729, 8835.072317406837, 5759.625624334405, 6187.041008643668, 6266.749330026931, 6686.765963191265, 6799.796006119825, 7098.396636285974, 7319.0, 7347.926520734724, 7368.115826100902, 7376.520526165782, 6564.0, 6663.133792607124, 6675.7997260082275, 6770.458363330823, 6788.626625535643, 6340.809775706736, 6505.577137486048, 6574.737010519526, 6599.703013364314, 6659.2008958925235, 6690.230623478167, 6714.83212919681, 6732.697028633625, 6736.326367363225, 6758.020087087443, 6284.968575157095, 6306.306306306395, 6328.272248691275, 6346.714397852015, 6356.459700925473, 6358.745650173942, 6362.809115726535, 6364.299927008118, 6381.138546296376, 6384.680765961776], "unit": "score", "name": "mootools.html", "value": 4477.706765792135}, {"lowerIsBetter": false, "replicates": [337.09321924024385, 338.3267298076826, 339.8793428332942, 342.7104097038003, 346.2071855451017, 5827.796027139051, 5849.619774714652, 5861.765529378825, 5863.706814659271, 5863.79476718315, 5757.280339957505, 5759.020966435705, 5768.769249230037, 5774.538036957044, 5785.27684039495, 4282.7858607069675, 4368.890777730567, 4450.176717307292, 4499.325101234808, 4533.2066888294585, 4451.510333863289, 4476.686631935766, 4486.057927835142, 4498.730076195438, 4499.730016199022, 4420.425344705184, 4453.888652783674, 4454.621357184643, 4459.17505261526, 4465.37484752135, 4259.2546304396765, 4377.934330985037, 4455.933161002587, 4496.3705081288645, 4500.257457519506, 3979.263836190314, 3980.7412518186225, 3988.900277493057, 3991.9221810111108, 3995.2409042281874, 5471.015217260891, 5475.835724928259, 5485.314335708036, 5487.0, 5490.203920431555, 5226.425093239741, 5237.47625237477, 5239.580833533309, 5241.0, 5248.0553500369915, 6055.515558755289, 6101.450869421773, 6112.449879510821, 6122.693865306717, 6131.662758548278, 4110.383442483621, 4213.4522512073545, 4218.7468751874985, 4409.911801763947, 4432.135733531963, 6172.938270617281, 6315.115883776275, 6320.399562041599, 6338.0, 6362.013887847437, 4310.956890431055, 4316.028893498938, 4320.265554855682, 4320.524742278347, 4324.589164029412, 4353.498043175099, 4368.213721530155, 4368.825246990148, 4370.0, 4371.628411584988, 5039.924401133986, 5069.417017043087, 5076.035553244872, 5078.5937125029905, 5081.7967281309075, 5987.0121429963565, 6122.938770612326, 6138.202033735586, 6139.938600613937, 6142.907856382158, 1538.946136885226, 1557.6339560203344, 1561.7423125184444, 1561.9921900390425, 1566.2560283865073, 982.3320142303303, 1011.2718842433436, 1031.5718976624767, 1065.9946700266448, 1066.0405634928627, 5761.193432919395, 5763.3084029915835, 5874.9118763218585, 5876.353601103875, 5889.676067816311, 6231.626102433868, 6260.718267677966, 6320.241571011508, 6322.841928951721, 6329.2721337045905, 5861.0915308127305, 5866.973279676125, 5873.676947767914, 5873.853153671193, 5874.823755287348, 3325.783824051429, 3359.8152101634646, 3363.613184483767, 3367.579052618423, 3367.6295607483157, 6368.140301059298, 6604.702788374535, 6609.504287178384, 6631.303713110054, 6636.767713130017, 6375.171227740364, 6402.9359706403275, 6426.775062872777, 6460.289368169498, 6489.253735820441, 6556.147700798961, 6570.605763654196, 6571.112899758567, 6571.737130514822, 6583.210014798159, 6241.157443745036, 6245.18812554365, 6253.468455181361, 6258.593191442542, 6264.2796078451565, 6029.4874935629205, 6188.3502232266765, 6194.442500175006, 6194.783182588588, 6196.10156527292, 6562.081308616893, 6567.770128045496, 6582.407583317525, 6593.835154121185, 6594.868102637824, 4361.149575832682, 4383.079553293716, 4384.342348647729, 4384.364267181305, 4388.84639037645, 6175.011998080286, 6260.937390626035, 6307.526935479766, 6320.273168585672, 6332.0818481320875, 6038.064100064497, 6056.364081771527, 6063.423974722395, 6067.878642427215, 6071.757129714939, 5960.731767070579, 6040.36576159497, 6051.878962420815, 6214.689265536615, 6221.720022598904, 6059.818205453844, 6082.239720034996, 6093.2078829751845, 6103.572749907464, 6106.45041946227, 6197.25632924052, 6226.40849119333, 6238.0, 6243.906341404791, 6275.121482992294, 5850.590458668023, 5937.614055086406, 6089.2997305310455, 6095.451409373178, 6097.420745029215], "unit": "score", "name": "prototype.html", "value": 4633.585686054043}, {"lowerIsBetter": false, "replicates": [737.6201256352979, 743.0488974113138, 745.9030326057612, 760.9923900760992, 762.1387831750123, 12332.136750427462, 12433.875661243384, 12475.37623118845, 12487.250764954098, 12550.874491255085, 12326.506939722423, 13889.930550347259, 14088.295585220749, 14098.859011409882, 14142.717145657081, 682.15412888019, 828.204923273658, 840.029765620706, 844.8141408890034, 845.0155568762384, 829.908710041898, 840.277361469136, 847.3052097280232, 849.2059923971076, 850.4557083466586, 869.7260362985671, 874.2001069021837, 874.8775171475999, 878.6880657366638, 879.3141349747208, 711.6833009310859, 862.3446180902497, 869.0961400143843, 870.425519157353, 873.5501216873315, 630.3224034163293, 631.0565704272096, 631.8199313195763, 632.2318383164431, 634.0362648773838, 12205.755884882252, 12510.437030333565, 12529.18560293578, 12531.060170487159, 12538.122331436804, 12043.277403355827, 12094.637160885188, 12124.090693198046, 12144.757104857854, 12199.756004879942, 9825.90174098257, 9888.0, 9948.552315145764, 10054.145397641209, 10158.492075396274, 3479.982600087009, 3510.9648903511147, 3567.928641427157, 3595.874144404959, 3654.780713157219, 49227.0, 49492.25761613579, 49528.257076143884, 49556.50443495555, 49644.50355496471, 9865.556049977768, 9911.0, 10213.295502625691, 10249.795004099877, 10273.743156421, 16798.244079016473, 16802.747958780627, 16843.74734378985, 16861.072641004863, 16878.915605421895, 7592.696292148252, 7599.202083781234, 7738.110117336579, 7858.1356050834365, 7873.0, 4208.431861698631, 4241.785763978581, 4327.6970612057485, 4365.519792822787, 4398.318260669601, 3045.193023848682, 3076.446239676835, 3078.199668086269, 3086.105029541453, 3087.1818967973504, 561.865152363438, 565.5842955427757, 566.1394680086246, 572.6277919352455, 573.8163787587932, 624.1231070346171, 657.4346062386344, 660.8909529927508, 666.1007639686482, 690.7513295213719, 7740.774976890576, 7842.764717058498, 7939.603019848984, 8015.47899386538, 8056.597170141469, 586.8943590153814, 601.4917394801386, 627.8792355645152, 635.8505751148476, 670.4636290967206, 3763.6800871926193, 3897.590752970954, 3942.2903877301787, 3942.704297177723, 3980.203959208112, 54210.18684719732, 55089.44910550924, 55220.72389638107, 55403.0, 55490.0, 46686.0, 47525.28712069322, 48165.5183448168, 48233.5176648236, 48465.0, 43845.78077109594, 44217.77891110524, 44677.0, 44710.77644611821, 44835.0, 7578.545287282781, 7831.490953088031, 7943.523388596703, 8049.959750201446, 8133.511989280662, 33788.3242335147, 33951.4907276396, 33970.66029339774, 34828.0, 34889.0, 39767.80116099401, 40847.0, 43095.35356969585, 43265.56734432741, 45984.31023534716, 10584.717904475772, 10664.093552048163, 10754.89245107539, 10872.695276566863, 10923.781524369628, 11675.532978680758, 11816.231944923553, 11902.821457678316, 12084.274943503418, 12426.130170888313, 11003.449827508754, 11193.216474847008, 11358.886411135783, 11388.316700997966, 11588.884111159117, 10143.64497242593, 10417.322874013165, 10543.525541350811, 10712.73218169552, 10813.945930270298, 10909.34543927367, 11004.39475828805, 11016.779664406828, 11363.147763917574, 11445.599404020819, 9361.297902657465, 9491.66779162726, 9497.525123743924, 9634.855477167988, 9833.754156146153, 8349.106620816805, 8564.503097225883, 8732.34507411934, 9038.051004644418, 9301.860472092789], "unit": "score", "name": "yui.html", "value": 6160.020367256166}], "name": "dromaeo_css", "value": 6738.18230081461}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 111.0, 113.0, 111.0, 99.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 156.0, 172.0, 128.0, 149.0, 157.0, 130.0, 169.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 159.0, 160.0, 163.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 99.0, 110.0, 76.0, 75.0, 73.0, 131.0, 103.0, 71.0], "unit": "score", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 150.0, 94.0, 94.0, 94.0, 148.0, 94.0, 94.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 60.0, 57.0, 57.0, 57.0, 60.0, 66.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 83.0, 91.0, 82.0, 81.0, 82.0, 81.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 121.0, 115.0, 112.0, 118.0, 117.0, 117.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [158.0, 148.0, 162.0, 152.0, 150.0, 142.0, 159.0, 144.0, 151.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 72.0, 70.0, 68.0, 69.0, 67.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1522.7000000000003}]} 16:16:32 INFO - Return code: 0 16:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:16:32 INFO - # TBPL SUCCESS # 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - Running post-run listener: _resource_record_post_run 16:16:34 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 28672; Write bytes: 541995008; Read time: 336; Write time: 637296 16:16:34 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 247627776; Read time: 0; Write time: 356440 16:16:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 28672; Write bytes: 293720064; Read time: 336; Write time: 280848 16:16:34 INFO - Running post-run listener: _upload_blobber_files 16:16:34 INFO - Blob upload gear active. 16:16:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:16:34 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 16:16:34 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:16:34 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:16:34 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:35 INFO - (blobuploader) - INFO - Done attempting. 16:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:36 INFO - (blobuploader) - INFO - Done attempting. 16:16:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:36 INFO - Return code: 0 16:16:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:16:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb18f18dab5e97024c559e5c1331e8c5334e32af2dee41f1038aee229060087c03ce53f05a8f4c0600a69829b3134e162d3940b2469f330c0872b0f207ca456d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512a4280b9d11c1c9c5f364aa4fc07ad12fe19d116a134614005dca1fa7dbed1e85b9012be329471a72326d92cef684c26b4537d852bd9595442a88e0673ff2e"} 16:16:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:16:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:16:36 INFO - Contents: 16:16:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb18f18dab5e97024c559e5c1331e8c5334e32af2dee41f1038aee229060087c03ce53f05a8f4c0600a69829b3134e162d3940b2469f330c0872b0f207ca456d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512a4280b9d11c1c9c5f364aa4fc07ad12fe19d116a134614005dca1fa7dbed1e85b9012be329471a72326d92cef684c26b4537d852bd9595442a88e0673ff2e"} 16:16:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:36 INFO - Copying logs to upload dir... 16:16:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:16:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.705176 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-04 16:16:36.344688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 16:16:36.348193) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb18f18dab5e97024c559e5c1331e8c5334e32af2dee41f1038aee229060087c03ce53f05a8f4c0600a69829b3134e162d3940b2469f330c0872b0f207ca456d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512a4280b9d11c1c9c5f364aa4fc07ad12fe19d116a134614005dca1fa7dbed1e85b9012be329471a72326d92cef684c26b4537d852bd9595442a88e0673ff2e"} build_url:https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/P71NCPdGRB-98lQ6M-mjmQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb18f18dab5e97024c559e5c1331e8c5334e32af2dee41f1038aee229060087c03ce53f05a8f4c0600a69829b3134e162d3940b2469f330c0872b0f207ca456d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512a4280b9d11c1c9c5f364aa4fc07ad12fe19d116a134614005dca1fa7dbed1e85b9012be329471a72326d92cef684c26b4537d852bd9595442a88e0673ff2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 16:16:36.378597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:16:36.378908) ========= 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=523ca41ca1e0623de333ad52000001bf-1457135764.927431-1495930234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 16:16:36.461658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 16:16:36.461982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 16:16:36.462276) ========= ========= Total master_lag: 0.22 =========