builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1460181791.32 results: success (0) buildid: 20160408203226 builduid: 1b78059156f14391a89a2e57ec2d2633 revision: 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.320577) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.321043) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.321518) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006451 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.361433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.361785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.473490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.474187) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.559350) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.559672) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.560062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.560384) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 23:03:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2016-04-08 23:03:12 (106 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.768442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.768816) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018749 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.819989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:11.820340) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 --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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 23:03:12,126 truncating revision to first 12 chars 2016-04-08 23:03:12,126 Setting DEBUG logging. 2016-04-08 23:03:12,126 attempt 1/10 2016-04-08 23:03:12,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81f58f4715ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 23:03:12,722 unpacking tar archive at: fx-team-81f58f4715ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:12.694341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:12.695093) ========= echo 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'81f58f4715ac5ec76ee7514ac172c2c66b1df6e1'] 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 program finished with exit code 0 elapsedTime=0.004859 script_repo_revision: '81f58f4715ac5ec76ee7514ac172c2c66b1df6e1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:12.754302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:12.754725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 23:03:12.773004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-08 23:03:12.773312) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:03:13 INFO - MultiFileLogger online at 20160408 23:03:13 in /builds/slave/test-pgo 23:03:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:03:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:03:13 INFO - {'append_to_log': False, 23:03:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:03:13 INFO - 'blob_upload_branch': 'Fx-Team', 23:03:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:03:13 INFO - 'branch': 'Fx-Team', 23:03:13 INFO - 'buildbot_json_path': 'buildprops.json', 23:03:13 INFO - 'config_files': ('talos/linux_config.py',), 23:03:13 INFO - 'default_actions': ('clobber', 23:03:13 INFO - 'read-buildbot-config', 23:03:13 INFO - 'download-and-extract', 23:03:13 INFO - 'populate-webroot', 23:03:13 INFO - 'create-virtualenv', 23:03:13 INFO - 'install', 23:03:13 INFO - 'run-tests'), 23:03:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:03:13 INFO - 'download_minidump_stackwalk': True, 23:03:13 INFO - 'download_symbols': 'ondemand', 23:03:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:03:13 INFO - 'tooltool.py': '/tools/tooltool.py', 23:03:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:03:13 INFO - '/tools/misc-python/virtualenv.py')}, 23:03:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:03:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:03:13 INFO - 'installer_path': 'installer.exe', 23:03:13 INFO - 'log_level': 'info', 23:03:13 INFO - 'log_name': 'talos', 23:03:13 INFO - 'log_to_console': True, 23:03:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:03:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:03:13 INFO - 'opt_config_files': (), 23:03:13 INFO - 'pip_index': False, 23:03:13 INFO - 'sps_profile': False, 23:03:13 INFO - 'sps_profile_interval': 0, 23:03:13 INFO - 'suite': 'dromaeojs-e10s', 23:03:13 INFO - 'system_bits': '32', 23:03:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:03:13 INFO - 'title': 'talos-linux64-ix-001', 23:03:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:03:13 INFO - 'use_talos_json': True, 23:03:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:03:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:03:13 INFO - 'work_dir': 'build'} 23:03:13 INFO - ##### 23:03:13 INFO - ##### Running clobber step. 23:03:13 INFO - ##### 23:03:13 INFO - Running pre-action listener: _resource_record_pre_action 23:03:13 INFO - Running main action method: clobber 23:03:13 INFO - rmtree: /builds/slave/test-pgo/build 23:03:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:03:13 INFO - Running post-action listener: _resource_record_post_action 23:03:13 INFO - ##### 23:03:13 INFO - ##### Running read-buildbot-config step. 23:03:13 INFO - ##### 23:03:13 INFO - Running pre-action listener: _resource_record_pre_action 23:03:13 INFO - Running main action method: read_buildbot_config 23:03:13 INFO - Using buildbot properties: 23:03:13 INFO - { 23:03:13 INFO - "project": "", 23:03:13 INFO - "product": "firefox", 23:03:13 INFO - "script_repo_revision": "production", 23:03:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:03:13 INFO - "repository": "", 23:03:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:03:13 INFO - "buildid": "20160408203226", 23:03:13 INFO - "pgo_build": "True", 23:03:13 INFO - "basedir": "/builds/slave/test-pgo", 23:03:13 INFO - "buildnumber": 632, 23:03:13 INFO - "slavename": "talos-linux64-ix-001", 23:03:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:03:13 INFO - "platform": "ubuntu64_hw", 23:03:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:03:13 INFO - "branch": "fx-team", 23:03:13 INFO - "repo_path": "integration/fx-team", 23:03:13 INFO - "revision": "81f58f4715ac5ec76ee7514ac172c2c66b1df6e1", 23:03:13 INFO - "stage_platform": "linux64-pgo", 23:03:13 INFO - "builduid": "1b78059156f14391a89a2e57ec2d2633", 23:03:13 INFO - "slavebuilddir": "test" 23:03:13 INFO - } 23:03:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:03:13 INFO - Running post-action listener: _resource_record_post_action 23:03:13 INFO - ##### 23:03:13 INFO - ##### Running download-and-extract step. 23:03:13 INFO - ##### 23:03:13 INFO - Running pre-action listener: _resource_record_pre_action 23:03:13 INFO - Running main action method: download_and_extract 23:03:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:03:13 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')]} 23:03:13 INFO - https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:03:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:03:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:03:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:03:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:03:25 INFO - Downloaded 1361 bytes. 23:03:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:03:25 INFO - Using the following test package requirements: 23:03:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:03:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:03:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:03:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'jsshell-linux-x86_64.zip'], 23:03:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:03:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:03:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:03:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:03:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:03:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:03:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:03:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:03: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')]} 23:03:25 INFO - https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:03:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:03:36 INFO - Downloaded 23758358 bytes. 23:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:03:38 INFO - Return code: 0 23:03:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:38 INFO - https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:03:39 INFO - Downloaded 23758358 bytes. 23:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:03:40 INFO - Return code: 0 23:03:40 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')]} 23:03:40 INFO - https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:03:42 INFO - Downloaded 10847693 bytes. 23:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:03:42 INFO - Return code: 0 23:03:42 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')]} 23:03:42 INFO - https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:03:43 INFO - Downloaded 57745284 bytes. 23:03:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:03:43 INFO - mkdir: /builds/slave/test-pgo/properties 23:03:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:03:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:03:43 INFO - Contents: 23:03:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:03:44 INFO - Running post-action listener: _resource_record_post_action 23:03:44 INFO - Running post-action listener: set_extra_try_arguments 23:03:44 INFO - ##### 23:03:44 INFO - ##### Running populate-webroot step. 23:03:44 INFO - ##### 23:03:44 INFO - Running pre-action listener: _resource_record_pre_action 23:03:44 INFO - Running main action method: populate_webroot 23:03:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:03:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:03:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:03:44 INFO - '--tppagecycles', 23:03:44 INFO - '7'], 23:03:44 INFO - 'tests': ['tsvgm']}}, 23:03:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:03:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:03:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:03:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:03:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:03:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:03:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['damp', 'tps']}, 23:03:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'tests': ['damp', 'tps']}, 23:03:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['dromaeo_dom']}, 23:03:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:03:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['a11yr', 23:03:44 INFO - 'ts_paint', 23:03:44 INFO - 'tpaint', 23:03:44 INFO - 'sessionrestore', 23:03:44 INFO - 'sessionrestore_no_auto_restore', 23:03:44 INFO - 'tabpaint']}, 23:03:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['tsvgx', 23:03:44 INFO - 'tsvgr_opacity', 23:03:44 INFO - 'tart', 23:03:44 INFO - 'tscrollx', 23:03:44 INFO - 'cart']}, 23:03:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:03:44 INFO - 'tsvgr_opacity', 23:03:44 INFO - 'tart', 23:03:44 INFO - 'tscrollx', 23:03:44 INFO - 'cart']}, 23:03:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'talos_options': ['--disable-e10s'], 23:03:44 INFO - 'tests': ['tp5o']}, 23:03:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'tests': ['tp5o']}, 23:03:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'talos_options': ['--disable-e10s', 23:03:44 INFO - '--xperf_path', 23:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:03:44 INFO - 'tests': ['tp5n']}, 23:03:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:03:44 INFO - 'talos_options': ['--xperf_path', 23:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:03:44 INFO - 'tests': ['tp5n']}}, 23:03:44 INFO - 'talos.zip': {'path': '', 23:03:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:03:44 INFO - Running post-action listener: _resource_record_post_action 23:03:44 INFO - ##### 23:03:44 INFO - ##### Running create-virtualenv step. 23:03:44 INFO - ##### 23:03:44 INFO - Running pre-action listener: _resource_record_pre_action 23:03:44 INFO - Running main action method: create_virtualenv 23:03:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:03:44 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 23:03:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:03:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:03:44 INFO - Using real prefix '/usr' 23:03:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:03:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:03:47 INFO - Installing pip.................done. 23:03:47 INFO - Return code: 0 23:03:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:47 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:47 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 23:03:47 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 23:03:47 INFO - Using env: {'DISPLAY': ':0', 23:03:47 INFO - 'HOME': '/home/cltbld', 23:03:47 INFO - 'LANG': 'en_US.UTF-8', 23:03:47 INFO - 'LANGUAGE': 'en_US:en', 23:03:47 INFO - 'LOGNAME': 'cltbld', 23:03:47 INFO - 'MAIL': '/var/mail/cltbld', 23:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:47 INFO - 'MOZ_NO_REMOTE': '1', 23:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:47 INFO - 'NO_EM_RESTART': '1', 23:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:47 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:47 INFO - 'SHELL': '/bin/bash', 23:03:47 INFO - 'SHLVL': '1', 23:03:47 INFO - 'TERM': 'linux', 23:03:47 INFO - 'TMOUT': '86400', 23:03:47 INFO - 'USER': 'cltbld', 23:03:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:47 INFO - '_': '/tools/buildbot/bin/python'} 23:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:47 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 23:03:47 INFO - Cleaning up... 23:03:47 INFO - Return code: 0 23:03:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:47 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:47 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 23:03:47 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 23:03:47 INFO - Using env: {'DISPLAY': ':0', 23:03:47 INFO - 'HOME': '/home/cltbld', 23:03:47 INFO - 'LANG': 'en_US.UTF-8', 23:03:47 INFO - 'LANGUAGE': 'en_US:en', 23:03:47 INFO - 'LOGNAME': 'cltbld', 23:03:47 INFO - 'MAIL': '/var/mail/cltbld', 23:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:47 INFO - 'MOZ_NO_REMOTE': '1', 23:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:47 INFO - 'NO_EM_RESTART': '1', 23:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:47 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:47 INFO - 'SHELL': '/bin/bash', 23:03:47 INFO - 'SHLVL': '1', 23:03:47 INFO - 'TERM': 'linux', 23:03:47 INFO - 'TMOUT': '86400', 23:03:47 INFO - 'USER': 'cltbld', 23:03:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:47 INFO - '_': '/tools/buildbot/bin/python'} 23:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:47 INFO - Downloading/unpacking psutil>=0.7.1 23:03:47 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 23:03:47 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 23:03:47 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 23:03:47 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 23:03:47 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 23:03:47 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 23:03:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:49 INFO - Installing collected packages: psutil 23:03:49 INFO - Running setup.py install for psutil 23:03:49 INFO - building 'psutil._psutil_linux' extension 23:03:49 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 23:03:50 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 23:03:50 INFO - building 'psutil._psutil_posix' extension 23:03:50 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 23:03:50 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 23:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:50 INFO - Successfully installed psutil 23:03:50 INFO - Cleaning up... 23:03:50 INFO - Return code: 0 23:03:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:50 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:50 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 23:03:50 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 23:03:50 INFO - Using env: {'DISPLAY': ':0', 23:03:50 INFO - 'HOME': '/home/cltbld', 23:03:50 INFO - 'LANG': 'en_US.UTF-8', 23:03:50 INFO - 'LANGUAGE': 'en_US:en', 23:03:50 INFO - 'LOGNAME': 'cltbld', 23:03:50 INFO - 'MAIL': '/var/mail/cltbld', 23:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:50 INFO - 'MOZ_NO_REMOTE': '1', 23:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:50 INFO - 'NO_EM_RESTART': '1', 23:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:50 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:50 INFO - 'SHELL': '/bin/bash', 23:03:50 INFO - 'SHLVL': '1', 23:03:50 INFO - 'TERM': 'linux', 23:03:50 INFO - 'TMOUT': '86400', 23:03:50 INFO - 'USER': 'cltbld', 23:03:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:50 INFO - '_': '/tools/buildbot/bin/python'} 23:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:03:50 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 23:03:50 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 23:03:50 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 23:03:50 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 23:03:50 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 23:03:50 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 23:03:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:03:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:03:52 INFO - Installing collected packages: mozsystemmonitor 23:03:52 INFO - Running setup.py install for mozsystemmonitor 23:03:52 INFO - Successfully installed mozsystemmonitor 23:03:52 INFO - Cleaning up... 23:03:52 INFO - Return code: 0 23:03:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:52 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:52 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 23:03:52 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 23:03:52 INFO - Using env: {'DISPLAY': ':0', 23:03:52 INFO - 'HOME': '/home/cltbld', 23:03:52 INFO - 'LANG': 'en_US.UTF-8', 23:03:52 INFO - 'LANGUAGE': 'en_US:en', 23:03:52 INFO - 'LOGNAME': 'cltbld', 23:03:52 INFO - 'MAIL': '/var/mail/cltbld', 23:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:52 INFO - 'MOZ_NO_REMOTE': '1', 23:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:52 INFO - 'NO_EM_RESTART': '1', 23:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:52 INFO - 'SHELL': '/bin/bash', 23:03:52 INFO - 'SHLVL': '1', 23:03:52 INFO - 'TERM': 'linux', 23:03:52 INFO - 'TMOUT': '86400', 23:03:52 INFO - 'USER': 'cltbld', 23:03:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:52 INFO - '_': '/tools/buildbot/bin/python'} 23:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:03:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:03:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:03:54 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 23:03:54 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 23:03:54 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 23:03:54 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 23:03:54 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 23:03:54 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 23:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:03:55 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 23:03:55 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 23:03:55 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 23:03:55 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 23:03:55 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 23:03:55 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 23:03:55 INFO - Downloading docopt-0.6.1.tar.gz 23:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:03:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:03:55 INFO - Running setup.py install for blobuploader 23:03:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:03:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:03:55 INFO - Running setup.py install for requests 23:03:56 INFO - Running setup.py install for docopt 23:03:56 INFO - Successfully installed blobuploader requests docopt 23:03:56 INFO - Cleaning up... 23:03:56 INFO - Return code: 0 23:03:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:56 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:56 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 23:03:56 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 23:03:56 INFO - Using env: {'DISPLAY': ':0', 23:03:56 INFO - 'HOME': '/home/cltbld', 23:03:56 INFO - 'LANG': 'en_US.UTF-8', 23:03:56 INFO - 'LANGUAGE': 'en_US:en', 23:03:56 INFO - 'LOGNAME': 'cltbld', 23:03:56 INFO - 'MAIL': '/var/mail/cltbld', 23:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:56 INFO - 'MOZ_NO_REMOTE': '1', 23:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:56 INFO - 'NO_EM_RESTART': '1', 23:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:56 INFO - 'SHELL': '/bin/bash', 23:03:56 INFO - 'SHLVL': '1', 23:03:56 INFO - 'TERM': 'linux', 23:03:56 INFO - 'TMOUT': '86400', 23:03:56 INFO - 'USER': 'cltbld', 23:03:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:56 INFO - '_': '/tools/buildbot/bin/python'} 23:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:56 INFO - Running setup.py (path:/tmp/pip-H9nMxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:56 INFO - Running setup.py (path:/tmp/pip-_zmtvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:56 INFO - Running setup.py (path:/tmp/pip-nC0Lw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:56 INFO - Running setup.py (path:/tmp/pip-WR_fM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:56 INFO - Running setup.py (path:/tmp/pip-lhU57i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:56 INFO - Running setup.py (path:/tmp/pip-vGakeN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:56 INFO - Running setup.py (path:/tmp/pip-l80CdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:56 INFO - Running setup.py (path:/tmp/pip-eVj3CM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:57 INFO - Running setup.py (path:/tmp/pip-V7NdOM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:57 INFO - Running setup.py (path:/tmp/pip-s0lX4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:57 INFO - Running setup.py (path:/tmp/pip-RzbA5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:57 INFO - Running setup.py (path:/tmp/pip-FaeJso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:57 INFO - Running setup.py (path:/tmp/pip-gQAezi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:57 INFO - Running setup.py (path:/tmp/pip-__RVoZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:57 INFO - Running setup.py (path:/tmp/pip-XhtFQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:57 INFO - Running setup.py (path:/tmp/pip-bbBEFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:57 INFO - Running setup.py (path:/tmp/pip-n_SMA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:03:57 INFO - Running setup.py install for manifestparser 23:03:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:03:57 INFO - Running setup.py install for mozcrash 23:03:57 INFO - Running setup.py install for mozdebug 23:03:57 INFO - Running setup.py install for mozdevice 23:03:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for mozfile 23:03:58 INFO - Running setup.py install for mozhttpd 23:03:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for mozinfo 23:03:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for mozInstall 23:03:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for mozleak 23:03:58 INFO - Running setup.py install for mozlog 23:03:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for moznetwork 23:03:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:03:58 INFO - Running setup.py install for mozprocess 23:03:58 INFO - Running setup.py install for mozprofile 23:03:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:03:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:03:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:03:59 INFO - Running setup.py install for mozrunner 23:03:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:03:59 INFO - Running setup.py install for mozscreenshot 23:03:59 INFO - Running setup.py install for moztest 23:03:59 INFO - Running setup.py install for mozversion 23:03:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:03:59 INFO - Cleaning up... 23:03:59 INFO - Return code: 0 23:03:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:59 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:03:59 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 23:03:59 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 23:03:59 INFO - Using env: {'DISPLAY': ':0', 23:03:59 INFO - 'HOME': '/home/cltbld', 23:03:59 INFO - 'LANG': 'en_US.UTF-8', 23:03:59 INFO - 'LANGUAGE': 'en_US:en', 23:03:59 INFO - 'LOGNAME': 'cltbld', 23:03:59 INFO - 'MAIL': '/var/mail/cltbld', 23:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:59 INFO - 'MOZ_NO_REMOTE': '1', 23:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:59 INFO - 'NO_EM_RESTART': '1', 23:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:59 INFO - 'SHELL': '/bin/bash', 23:03:59 INFO - 'SHLVL': '1', 23:03:59 INFO - 'TERM': 'linux', 23:03:59 INFO - 'TMOUT': '86400', 23:03:59 INFO - 'USER': 'cltbld', 23:03:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:59 INFO - '_': '/tools/buildbot/bin/python'} 23:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:59 INFO - Running setup.py (path:/tmp/pip-rTngXd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:59 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)) 23:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:59 INFO - Running setup.py (path:/tmp/pip-RgBQkr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:59 INFO - Running setup.py (path:/tmp/pip-khTRK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:59 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)) 23:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:59 INFO - Running setup.py (path:/tmp/pip-fV3Oi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:59 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)) 23:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:59 INFO - Running setup.py (path:/tmp/pip-W6Mt1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:00 INFO - Running setup.py (path:/tmp/pip-bv7vDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:00 INFO - Running setup.py (path:/tmp/pip-4MUMm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:00 INFO - Running setup.py (path:/tmp/pip-ErQgH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:00 INFO - Running setup.py (path:/tmp/pip-A6d4dD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:00 INFO - Running setup.py (path:/tmp/pip-T6BWzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:00 INFO - Running setup.py (path:/tmp/pip-d1PdbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:00 INFO - Running setup.py (path:/tmp/pip-IWxLTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:00 INFO - Running setup.py (path:/tmp/pip-KIXXNg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:00 INFO - Running setup.py (path:/tmp/pip-zvdFE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:00 INFO - Running setup.py (path:/tmp/pip-7NXyvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:00 INFO - Running setup.py (path:/tmp/pip-j3U2Ao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:04:00 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)) 23:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:00 INFO - Running setup.py (path:/tmp/pip-pYoSVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:04:00 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)) 23:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:04:00 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)) 23:04:00 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)) 23:04:00 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)) 23:04:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:02 INFO - Downloading blessings-1.6.tar.gz 23:04:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:04:02 INFO - Installing collected packages: blessings 23:04:02 INFO - Running setup.py install for blessings 23:04:02 INFO - Successfully installed blessings 23:04:02 INFO - Cleaning up... 23:04:03 INFO - Return code: 0 23:04:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:04:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:04:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:04:03 INFO - Reading from file tmpfile_stdout 23:04:03 INFO - Current package versions: 23:04:03 INFO - argparse == 1.2.1 23:04:03 INFO - blessings == 1.6 23:04:03 INFO - blobuploader == 1.2.4 23:04:03 INFO - docopt == 0.6.1 23:04:03 INFO - manifestparser == 1.1 23:04:03 INFO - mozInstall == 1.12 23:04:03 INFO - mozcrash == 0.17 23:04:03 INFO - mozdebug == 0.1 23:04:03 INFO - mozdevice == 0.48 23:04:03 INFO - mozfile == 1.2 23:04:03 INFO - mozhttpd == 0.7 23:04:03 INFO - mozinfo == 0.9 23:04:03 INFO - mozleak == 0.1 23:04:03 INFO - mozlog == 3.1 23:04:03 INFO - moznetwork == 0.27 23:04:03 INFO - mozprocess == 0.22 23:04:03 INFO - mozprofile == 0.28 23:04:03 INFO - mozrunner == 6.11 23:04:03 INFO - mozscreenshot == 0.1 23:04:03 INFO - mozsystemmonitor == 0.0 23:04:03 INFO - moztest == 0.7 23:04:03 INFO - mozversion == 1.4 23:04:03 INFO - psutil == 3.1.1 23:04:03 INFO - requests == 1.2.3 23:04:03 INFO - wsgiref == 0.1.2 23:04:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:04:03 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')]} 23:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:03 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')]} 23:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:03 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:04:03 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 23:04:03 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 23:04:03 INFO - Using env: {'DISPLAY': ':0', 23:04:03 INFO - 'HOME': '/home/cltbld', 23:04:03 INFO - 'LANG': 'en_US.UTF-8', 23:04:03 INFO - 'LANGUAGE': 'en_US:en', 23:04:03 INFO - 'LOGNAME': 'cltbld', 23:04:03 INFO - 'MAIL': '/var/mail/cltbld', 23:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:03 INFO - 'MOZ_NO_REMOTE': '1', 23:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:03 INFO - 'NO_EM_RESTART': '1', 23:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:03 INFO - 'SHELL': '/bin/bash', 23:04:03 INFO - 'SHLVL': '1', 23:04:03 INFO - 'TERM': 'linux', 23:04:03 INFO - 'TMOUT': '86400', 23:04:03 INFO - 'USER': 'cltbld', 23:04:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:03 INFO - '_': '/tools/buildbot/bin/python'} 23:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 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)) 23:04:03 INFO - Cleaning up... 23:04:03 INFO - Return code: 0 23:04:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:04:03 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')]} 23:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:03 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')]} 23:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:03 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:04:03 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 23:04:03 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 23:04:03 INFO - Using env: {'DISPLAY': ':0', 23:04:03 INFO - 'HOME': '/home/cltbld', 23:04:03 INFO - 'LANG': 'en_US.UTF-8', 23:04:03 INFO - 'LANGUAGE': 'en_US:en', 23:04:03 INFO - 'LOGNAME': 'cltbld', 23:04:03 INFO - 'MAIL': '/var/mail/cltbld', 23:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:03 INFO - 'MOZ_NO_REMOTE': '1', 23:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:03 INFO - 'NO_EM_RESTART': '1', 23:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:03 INFO - 'SHELL': '/bin/bash', 23:04:03 INFO - 'SHLVL': '1', 23:04:03 INFO - 'TERM': 'linux', 23:04:03 INFO - 'TMOUT': '86400', 23:04:03 INFO - 'USER': 'cltbld', 23:04:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:03 INFO - '_': '/tools/buildbot/bin/python'} 23:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:03 INFO - Downloading/unpacking jsonschema 23:04:03 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 23:04:03 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 23:04:03 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 23:04:03 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 23:04:03 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 23:04:03 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 23:04:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:04:05 INFO - Downloading/unpacking functools32 (from jsonschema) 23:04:05 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 23:04:05 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 23:04:05 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 23:04:05 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 23:04:05 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 23:04:05 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 23:04:05 INFO - Downloading functools32-3.2.3-2.tar.gz 23:04:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:04:05 INFO - warning: no files found matching '*.txt' 23:04:05 INFO - no previously-included directories found matching 'build' 23:04:05 INFO - no previously-included directories found matching 'dist' 23:04:05 INFO - no previously-included directories found matching '.git*' 23:04:05 INFO - Installing collected packages: jsonschema, functools32 23:04:05 INFO - Running setup.py install for functools32 23:04:05 INFO - warning: no files found matching '*.txt' 23:04:05 INFO - no previously-included directories found matching 'build' 23:04:05 INFO - no previously-included directories found matching 'dist' 23:04:05 INFO - no previously-included directories found matching '.git*' 23:04:06 INFO - Successfully installed jsonschema functools32 23:04:06 INFO - Cleaning up... 23:04:06 INFO - Return code: 0 23:04:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:04:06 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')]} 23:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:06 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')]} 23:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:06 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 0x7f73c3ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, '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': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', '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 23:04:06 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 23:04:06 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 23:04:06 INFO - Using env: {'DISPLAY': ':0', 23:04:06 INFO - 'HOME': '/home/cltbld', 23:04:06 INFO - 'LANG': 'en_US.UTF-8', 23:04:06 INFO - 'LANGUAGE': 'en_US:en', 23:04:06 INFO - 'LOGNAME': 'cltbld', 23:04:06 INFO - 'MAIL': '/var/mail/cltbld', 23:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:06 INFO - 'MOZ_NO_REMOTE': '1', 23:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:06 INFO - 'NO_EM_RESTART': '1', 23:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:06 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:06 INFO - 'SHELL': '/bin/bash', 23:04:06 INFO - 'SHLVL': '1', 23:04:06 INFO - 'TERM': 'linux', 23:04:06 INFO - 'TMOUT': '86400', 23:04:06 INFO - 'USER': 'cltbld', 23:04:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:06 INFO - '_': '/tools/buildbot/bin/python'} 23:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:06 INFO - Downloading/unpacking flake8 23:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:04:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:04:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 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 23:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:08 INFO - no previously-included directories found matching 'docs/_build' 23:04:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:04:08 INFO - Running setup.py install for pep8 23:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:08 INFO - no previously-included directories found matching 'docs/_build' 23:04:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:04:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:04:09 INFO - Cleaning up... 23:04:09 INFO - Return code: 0 23:04:09 INFO - Running post-action listener: _resource_record_post_action 23:04:09 INFO - Running post-action listener: _start_resource_monitoring 23:04:09 INFO - Starting resource monitoring. 23:04:09 INFO - ##### 23:04:09 INFO - ##### Running install step. 23:04:09 INFO - ##### 23:04:09 INFO - Running pre-action listener: _resource_record_pre_action 23:04:09 INFO - Running main action method: install 23:04:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:04:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:04:09 INFO - Reading from file tmpfile_stdout 23:04:09 INFO - Detecting whether we're running mozinstall >=1.0... 23:04:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:04:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:04:09 INFO - Reading from file tmpfile_stdout 23:04:09 INFO - Output received: 23:04:09 INFO - Usage: mozinstall [options] installer 23:04:09 INFO - Options: 23:04:09 INFO - -h, --help show this help message and exit 23:04:09 INFO - -d DEST, --destination=DEST 23:04:09 INFO - Directory to install application into. [default: 23:04:09 INFO - "/builds/slave/test-pgo"] 23:04:09 INFO - --app=APP Application being installed. [default: firefox] 23:04:09 INFO - mkdir: /builds/slave/test-pgo/build/application 23:04:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:04:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:04:25 INFO - Reading from file tmpfile_stdout 23:04:25 INFO - Output received: 23:04:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:04:25 INFO - Running post-action listener: _resource_record_post_action 23:04:25 INFO - ##### 23:04:25 INFO - ##### Running run-tests step. 23:04:25 INFO - ##### 23:04:25 INFO - Running pre-action listener: _resource_record_pre_action 23:04:25 INFO - Running main action method: run_tests 23:04:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:04:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:04:25 INFO - Python 2.7.3 23:04:25 INFO - Return code: 0 23:04:25 INFO - grabbing minidump binary from tooltool 23:04: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')]} 23:04:25 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 0x270a8b0>, '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 0x270b7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270bc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:04:25 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 23:04:25 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 23:04:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:04:25 INFO - Return code: 0 23:04:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:04:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:04:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:04:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:04:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:04:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:04:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:04:26 INFO - Return code: 0 23:04:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 23:04:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:04:26 INFO - Using env: {'DISPLAY': ':0', 23:04:26 INFO - 'HOME': '/home/cltbld', 23:04:26 INFO - 'LANG': 'en_US.UTF-8', 23:04:26 INFO - 'LANGUAGE': 'en_US:en', 23:04:26 INFO - 'LOGNAME': 'cltbld', 23:04:26 INFO - 'MAIL': '/var/mail/cltbld', 23:04:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:04:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:26 INFO - 'MOZ_NO_REMOTE': '1', 23:04:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:26 INFO - 'NO_EM_RESTART': '1', 23:04:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:04:26 INFO - 'PWD': '/builds/slave/test-pgo', 23:04:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:04:26 INFO - 'SHELL': '/bin/bash', 23:04:26 INFO - 'SHLVL': '1', 23:04:26 INFO - 'TERM': 'linux', 23:04:26 INFO - 'TMOUT': '86400', 23:04:26 INFO - 'USER': 'cltbld', 23:04:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005', 23:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:26 INFO - '_': '/tools/buildbot/bin/python'} 23:04:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:04:27 INFO - mozversion application_buildid: 20160408203226 23:04:27 INFO - mozversion application_changeset: 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 23:04:27 INFO - mozversion application_display_name: Nightly 23:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:04:27 INFO - mozversion application_name: Firefox 23:04:27 INFO - mozversion application_remotingname: firefox 23:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:04:27 INFO - mozversion application_vendor: Mozilla 23:04:27 INFO - mozversion application_version: 48.0a1 23:04:27 INFO - mozversion platform_buildid: 20160408203226 23:04:27 INFO - mozversion platform_changeset: 81f58f4715ac5ec76ee7514ac172c2c66b1df6e1 23:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:04:27 INFO - mozversion platform_version: 48.0a1 23:04:27 INFO - using testdate: 1460181867 23:04:27 INFO - actual date: 1460181867 23:04:27 INFO - starting webserver on 'localhost:39663' 23:04:27 INFO - SUITE-START | Running 2 tests 23:04:27 INFO - TEST-START | dromaeo_css 23:04:27 INFO - operating with platform_type : linux_ 23:04:27 INFO - Initialising browser for dromaeo_css test... 23:04:27 INFO - TEST-INFO | started process 22790 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvgIxXD/profile http://localhost:39663/getInfo.html) 23:04:30 INFO - PROCESS | 22790 | 23:04:30 INFO - PROCESS | 22790 | (process:22857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:04:31 INFO - PROCESS | 22790 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 23:04:31 INFO - PROCESS | 22790 | __metrics Screen width/height:1600/1200 23:04:31 INFO - PROCESS | 22790 | colorDepth:24 23:04:31 INFO - PROCESS | 22790 | Browser inner width/height: 1024/697 23:04:31 INFO - PROCESS | 22790 | __metrics 23:04:32 ERROR - PROCESS | 22790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 23:04:33 INFO - TEST-INFO | 22790: exit 0 23:04:33 INFO - Browser initialized. 23:04:33 INFO - Running cycle 1/1 for dromaeo_css test... 23:04:33 INFO - TEST-INFO | started process 22908 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvgIxXD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:04:34 INFO - PROCESS | 22908 | 23:04:34 INFO - PROCESS | 22908 | (process:22968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:04:44 INFO - PROCESS | 22908 | RSS: Main: 162988032 23:04:44 INFO - PROCESS | 22908 | 23:05:34 INFO - PROCESS | 22908 | 1460181934533 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] 23:07:42 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39663/tests/dromaeo/cssquery-ext.html) 23:07:43 INFO - PROCESS | 22908 | RSS: Main: 167821312 23:07:43 INFO - PROCESS | 22908 | 23:10:45 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-ext.html (next: http://localhost:39663/tests/dromaeo/cssquery-jquery.html) 23:10:46 INFO - PROCESS | 22908 | RSS: Main: 165015552 23:10:46 INFO - PROCESS | 22908 | 23:13:47 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39663/tests/dromaeo/cssquery-mootools.html) 23:13:48 INFO - PROCESS | 22908 | RSS: Main: 166227968 23:13:48 INFO - PROCESS | 22908 | 23:16:50 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39663/tests/dromaeo/cssquery-prototype.html) 23:16:50 INFO - PROCESS | 22908 | RSS: Main: 163483648 23:16:50 INFO - PROCESS | 22908 | 23:19:53 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39663/tests/dromaeo/cssquery-yui.html) 23:19:53 INFO - PROCESS | 22908 | RSS: Main: 164450304 23:19:53 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | Cycle 1(1): loaded http://localhost:39663/tests/dromaeo/cssquery-yui.html (next: http://localhost:39663/tests/dromaeo/cssquery-dojo.html) 23:22:56 INFO - PROCESS | 22908 | RSS: Main: 166510592 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | __start_tp_report 23:22:56 INFO - PROCESS | 22908 | _x_x_mozilla_page_load 23:22:56 INFO - PROCESS | 22908 | _x_x_mozilla_page_load_details 23:22:56 INFO - PROCESS | 22908 | |i|pagename|runs| 23:22:56 INFO - PROCESS | 22908 | |0;dojo.html;3131.9821058156103;3178.745700343972;3203.19920019995;3228.5318628798823;3230.3862266169426;5426.21319908613;5469.917951230735;5473.781048758045;5482.862928426786;5492.862678433031;5327.946720532803;5412.810551630694;5450.04624190767;5473.67157970522;5534.335879694432;4895.2412376081675;4911.852644420673;4975.402951645808;5005.874853128665;5048.899022019576;4922.950770492303;4956.900861982776;4993.75031248438;5002.574781143607;5057.241413787924;4886.389201349832;4893.608511319086;4924.60603151747;4930.457649658535;4970.353853998993;4906.730129842857;4939.506049395068;4950.554450099472;4955.925661115086;5001.624878134155;4824.951750482485;4900.901981960376;4905.460399356068;4932.556069953722;4970.279309500138;5277.604179686539;5296.947030529684;5332.786688532493;5346.03771321162;5350.705711185883;5758.1362795581;5761.395053519362;5761.798337058183;5767.048437007888;5778.537716982673;5664.773409063632;5816.243888294537;5832.737526811304;5837.708114594296;5861.88276234473;5476.780928762844;5483.506484416422;5483.725813709299;5484.808031718871;5531.612787104904;5924.052151655715;5967.940320596826;5969.432903874125;5969.76120955157;5987.580869339192;5526.640768350125;5690.2033715279895;5692.37383887772;5704.885902282014;5747.511461525817;5816.912746308809;5821.359650438449;5826.6795326256615;5828.417158284223;5833.533317334603;5654.095344744821;5728.341240757283;5794.710264486759;5873;5908.350081491032;5762.88474230513;5782.710864456844;5830.912536311958;5831.358550559435;5843.649381037151;4412.2499175139665;4412.801423935931;4415.646748260131;4439.511653718088;4470.8435204767675;3934.449177115206;3936.842526298973;3940.566537680853;3962.32640451124;3971.225611005884;5600.60795744294;5628.774849006076;5642.661440313512;5650.604457688005;5686.2607860977805;5853.326867410302;5880.588358814842;5918.644881307136;5928.7332070056955;5936.495397891142;5650.124230744241;5652.3217213934595;5653.095504719226;5660.037793575019;5660.433956604306;4777.163996300634;4850.95149048505;4886.315915771795;4890.559849613552;4913.041956818458;6037.758489660452;6069.211002569726;6081.5742897996715;6092.116643086816;6092.268927728701;5891.705414729161;5894.734736936934;5896.351401345934;5896.616719913192;5905.881882362242;5947.256592925884;6047.667378294236;6066.3023752269055;6090.086487026804;6127.988881834447;5720.656760594377;5730.3410107838135;5732.942670573408;5739.339975902824;5740.827775166752;5834.912476312774;5849.824505264849;5855.3559108497175;5862.94137058624;5864.384239654775;5542.473465020817;5775.624584402;5797.739101740347;5815.534757219497;5845.707714614337;5609.382967873612;5689.487946084872;5730.111832665943;5740.569457290637;5774.249347584787;5548.195511650707;5600.663960162403;5619.297587801525;5620.634658747332;5623.437656234344;5688.544916406595;5726.513246374105;5731.598788084794;5737.08206686928;5796;5584.609077364546;5597.860053498533;5607.943920560742;5624.74688639004;5628.690422026828 23:22:56 INFO - PROCESS | 22908 | |1;ext.html;610.9572329936904;642.2710223895879;655.2530115668136;663.9468842492599;690.1993687322706;35872.103197420074;36678;36844.81577592112;36986.81506592463;37042.25915481692;37183.25633487335;37559.81220093903;37896;37933.81033094838;38013.80993095031;8286.212809783075;8380.371472139583;8432.494050356998;8446.662133514683;8467.237948584627;8090.514569125871;8365.12166222544;8371.037330706955;8371.748847534584;8390.622421991025;8587.828243435128;8598.097199794025;8657.307415406784;8666.133386661346;8708.129187081304;8549.187827156411;8569.357298202629;8609.440386374865;8621.13788621139;8646.913530864675;8484.236418722283;8545.188207120314;8571.699990500303;8575.656973721043;8580.141985801432;34483.31033379344;37009.444858327144;37343;37488;37622;3376.3416133853907;3446.5174875517446;3535.3106144301873;3561.910952226215;3577.8032208228537;29208;29444.55833162504;29974.85012574945;30206.69793302061;30576.69423305783;4254.7021708480415;4283.164782867342;4295.806688699016;4323.589259020388;4327.156204540116;279410;288356;288648;288893;289758;63540;63653.363466364746;64008.67995660085;64053.35946640474;64097.35902641007;67262;68507.65746171237;68557.3144268551;68573;68830;16172.514824555283;16307.59231019234;16317.755233671505;16334.428295009619;16360.509184724477;13392.799108013387;13397.330133493286;13475.932620336836;13490.797638035438;13534.59396218115;20575.485612859797;20747.585048298948;20783;20808;21000.894995525232;7657.272559106876;7694.846103077907;7762.961185194038;7952.558427673603;7979.680812767424;997.6857289953641;1063.134199479908;1064.914806815453;1101.581399068349;1112.249231768553;30382.54426183609;30709.69290307068;31172.220694482818;31878;32046.83976580102;1108.6507750058706;1127.7969965406305;1157.6179860645966;1212.8423304970297;1232.168286406672;16105.436309729103;16118.274677639534;16614.252358643647;16759.497215083567;16762.74855877163;432128;436938;438258;438979;442558;55808.72095639577;56146.87706245852;56151;56317;56628.15057774137;1403.7052219034117;1415.4762737787084;1431.0698046270008;1451.1438251431705;1458.4749490183738;29877.402451950406;30231.769586724076;30422.543661844647;30924;30977.535336970413;48113.75943120262;49809.25286120638;49999;50174.2473862885;50249.49750502448;384467;386267;387720;387737;388373;28465.715342847136;28671.42657146887;28932.710672893;29220.26949326284;29280.26799330034;41484.58515414807;41560;43601.34597981096;46204.768976154905;47063.294050588585;39350.40974385329;39358.21283574255;39486.80256598699;39770.204595907344;40848.79575602103;37892;39126.6087339123;39182;39305;40091.59908400878;40267;40536.59463405328;40764.38853417142;40805.59194408018;41092.589074110074;32340.83829580837;33295.83689549489;33668.59504544794;34299;34318.31363372769;27305.31736706598;27329.590056148776;27534.586981195698;27559.586606201323;27821.44357112806 23:22:56 INFO - PROCESS | 22908 | |2;jquery.html;394.8894309593313;400.64542879551607;401.7388697346722;407.4377359244243;410.2512913932073;14542.636434089127;17933.82066179338;18609.53476163095;18684.439466815984;18686.97221652812;17619.207135678895;17810.109494525288;18124.728129078074;18520;18543.536411589717;5094.133997220472;5239.816606418776;5482.533984611313;5864.941350586503;5873.412658734113;5725.713714314288;5773.364929857712;5785.27684039495;5785.8264252072295;5797;5746.994276001704;6520.706568204442;6865.965670171642;6890.517663763539;6894.345037221481;6695.732170713166;6834;7181.425485961111;7183.533070350462;7196.712131514733;6632.204135503722;6877.862442751167;6903.75836845713;6978.581285122909;7063.6115013674225;23079.423014424607;23201.53596928052;23722.169724059746;24450.699155613944;25694;2450.82844200906;2635.472905418924;2665.6667916510437;2681.5977603359456;2938.471075206462;15698.136602486858;15719.214039297989;15899.761503577456;16072.75890861638;16097.758533621887;2054.5685406064745;2120.8759357540375;2134.263679030732;2198.604251234777;2217.545403192342;88588.55705721494;89855.99999999935;92087;92337.53831230868;93052.53473732655;16684.74972875408;16766.916165419094;17212.225449854788;17223.22495487706;17511.474655760347;14512;15342.69587085088;31054;31328.21679458032;31453.528197077063;7892.894994700747;8023.679052837938;8042.276195142465;8126.918730812735;8202.302804261586;7458.813529661802;7620.657070431844;7670.4247181461615;7694.307512323918;7993.560354180576;4422.226110430726;4510.864674059783;4730.8711080013445;4818.445878723922;4871.8294859679745;2046.3656266557414;2048.416201382599;2054.7123402723632;2059.7013433052125;2067.4211220858183;912.6258234123977;961.0965692249264;1023.7287118913493;1045.895410458948;1128.7629597784558;16451.095189764437;18591.907040464983;18594.628107437777;18945.526361840788;19009.524761881064;962.605331813953;988.980220395588;1003.8243307421318;1021.97445063874;1032.1691038713757;10414.35829864534;10787.137029037658;10791.892081079246;10799.028087472165;10911.181661375269;485157;487647;498796;499263;500111;85428.57285713656;87387.56306218555;87505;88250.55874720713;88912;1040.8022475729588;1049.8897615750236;1052.305478384278;1052.7105046112226;1065.4725910674265;16384.67230655404;16556.42052528156;16685.66628667444;16868.57828554296;17080.65838683244;27577.724222757515;35356.76251331191;37520.6247937528;37547.06132346604;38890.22219555536;48446.75776621094;48466.757666211444;48772;49678.503214968834;50069.74965125151;8420;8470.534120623179;8654.913450865412;8766.0357360689;8777.435733418713;12317.199382040139;12977.935110324388;13162.60512184636;13223.801642975171;13244.735105298032;11174.88825111771;11334.489947952527;11442.48508817122;11533.653990380302;11668.358240296866;11244;11464.25482343645;11514.712132196762;11521.654350369503;11583.478743456397;7221.602811845399;9207.631694732403;11635.301881887113;11855.822162667395;11864.11019173548;8478.364122690946;8541.359398045295;8697.434666746642;8812.030676625438;8814.823703525766;11218.270812397168;11379.715507112389;11413.714657133638;11467.139964502529;11526.366049867338 23:22:56 INFO - PROCESS | 22908 | |3;mootools.html;1507.7210716017537;1540.48393788081;1635.9100249486273;1761.0578340587788;1770.9291628334868;7341.339279464847;8076.3538916886655;8077.353811695065;8359.749207523777;8385.413021088527;8162.795930101751;8206.548639824807;8218.54797986112;8252.381071419637;8288.792780180498;2353.6587194856734;2366.065404165354;2394.449276666368;2394.95210095798;2400.2919138853995;2326.2439707095177;2348.988255058731;2350.529894021194;2351.870647114408;2352.3648614873973;2274.3290729234914;2279;2285.0174424997244;2301.884905754714;2306.7808558186944;2220.609001770119;2250.7861753133507;2251.2120757734824;2256.334381357495;2268.3421807675754;2268.7844654757773;2274.636058230675;2279.452931296477;2279.908803647852;2286.3826766773045;8275.668973241063;8358.707445239448;8384.161583841627;8398.076211616717;8405.159484051606;4939.827106051271;5030.170021946375;5092.414372347191;5092.719900405476;5113.872153196163;3208.983955080233;3210.7752457327997;3251.1872031992;3290.226796702773;3296.620888597818;1123.606737641827;1130.327455164176;1134.7049767060541;1142.8914253145938;1158.7161145519317;11472.598459053977;11543.711407214887;11570.94214528922;11609.6517104487;11621.605407351002;4438.689291749546;4530.614897733663;4561.977190114028;4589.403377560962;4600.907981840344;9592.76018099553;9710.951445242728;9768.316217864682;9796;9808.21534277256;5012.072766538202;5037.319961805109;5066.46802085783;5072.315237442972;5096.719680417613;4146.854860079943;4630.884227894329;4684.625229981593;4733.219018861918;4739.312799644102;3902.1415288636454;3919.0594257378025;4025.577314382006;4029.4560234368573;4108.4453598764385;1226.6320103968774;1228.8648248692637;1234.0682784497646;1237.7215126596443;1244;1374.3197117426937;1377.435251546861;1404.1996062244423;1414.0949792133042;1423.110555902561;7972.2824945755165;8052.637631306605;8103.513789172668;8143.674253029931;8168.9183108169345;1038.6364772329623;1082.123479981202;1122.6912599035168;1154.5151036564496;1166.7374840660784;6213.502919766408;6318.48356394462;6384.32964538726;6401.64790936503;6401.839954001094;9578.664746733832;10216.795664086676;10265.692029239135;10319.896801032044;10336.586536538454;9961.402315860927;10257.794844103077;10276.691699249035;10378.169746420268;10436.947815260875;7765.184655611192;7789.026371703537;7793.103793063757;7806.18035106317;7861.174576669482;7613.276738709814;7703.537787732754;7712.884306735516;8003.91996080055;8011.719589814328;9306.92970308396;9414.2468602513;9424.528773561158;9525.476098814632;9618.326717129734;9393.906060939304;9573.760655983377;9658.613655453702;9766.462844543334;9873.753156171153;6826.658667066527;7155.534890232118;7316.487845850952;7445.739399121005;7614.238576142341;8055.1944805521325;8074.313683336747;8081.313088387553;8111.391645626483;8135.75592732219;7159.140903091662;7390.630468476447;7396.852062958603;7428.851422971402;7509.9249007509225;6962.756303529352;6970.442364610921;6975.058367120374;7063.328983746535;7281.526700764433;7618.771436856903;7667;7702.845943081219;7759;7793.337566306701;7033.613151276729;7039.894401583878;7113.679884405317;7114.893276600958;7147.571145731273;7166.104236970379;7168.677409516688;7241.5293005954445;7249.275072492708;7260.67326970277 23:22:56 INFO - PROCESS | 22908 | |4;prototype.html;340.6644455211616;341.8478776944259;347;352.9611742708303;354.43113802347233;5957.731902064406;5964.373740757218;5988.580799344048;6002.759889604411;6074.149619053325;5858.853528661775;5899.410058994098;5900.232969713942;5925.762969481227;5929.614575052629;4267.551907049761;4503.954960450386;4512.9097418051615;4518.5481451854885;4538.727676339414;4481.932771008437;4491.505934347219;4495.370648109268;4512.616427603642;4516.593506584407;4492.505824359318;4494.37078808967;4506.52681468446;4541.500434952152;4573.359729637853;4440.955590444087;4452.621527170194;4482.050308115964;4491.348754430622;4495.168393847116;3894.0264933766557;3896.883093507199;3917.4907262056036;3922.0783115967724;3932.1518886123476;5643.40744221859;5654.349749778746;5701.54610574305;5737.426257374271;5753.367129615781;4925.704457732548;5202.167653175474;5203.947960520422;5225.242339860737;5285.471452854684;6149.262088549358;6194.628322300631;6214.378562143795;6254.530910181755;6275;4259.190753756776;4260.893477663052;4303.182395344875;4307.289297265947;4311.461067366579;6203.596766210182;6390.840228994266;6561.311062338434;6570.244421891448;6600.702968366387;4491.528389519053;4530.886727831765;4532.501424843264;4533.138703646297;4543.750093744876;4531.773411329486;4566.725996440225;4574.6569007323915;4596.5863072323655;4597.333386658983;5000.524950129732;5250.823251932526;5258.079836028756;5280.234366016906;5304.655197412233;6277.811665650038;6339.714712837934;6349.841253968595;6350.396712312323;6356.237251529754;1563.1558958162693;1572.701186774509;1580.9604759880865;1585.7542080977466;1591.6498370358502;1015.5277795824977;1054.514923135351;1059.2902755154066;1062.1131355318396;1076.6608518316705;5935.52515798735;5939.584229103922;6041.5468839837185;6045.21412216409;6048.459646948292;6424.453921416732;6453.354664533509;6453.548251622436;6459.547831651833;6465.579737317059;5827.59206855516;5997.310309314485;6011.458968692838;6012.699365031731;6023.216981792339;3404;3426.9205200361807;3453.5292031508175;3462.9480557791653;3465.70541503975;6490.772822951174;6572.277049524549;6613.437857782143;6623.635700036448;6629;6360.173177486897;6401.295857455676;6454;6459.547831651833;6492.67536623167;6479.870402591921;6608.2400523939405;6611.173603299588;6615.470762339001;6624.304448032984;6284.24589049317;6370.267419246846;6384.9042264367;6414.711337989895;6441.935580644321;6158.967540711644;6234.1583886174785;6322.292980895225;6324.430801227912;6328.6202827830475;6788.830279243059;6809.994653929259;6812.956113166129;6838.555493892881;6855.6572171390235;4360.127974405068;4384.780760962003;4406.669499787465;4414.646828253668;4418.403515525363;6326.588771729823;6505;6542.738290468328;6562.606243625398;6635.203775546772;6238.095476156022;6247.281562620356;6322.430981211529;6362.586431881913;6426.518011149276;6070.423309785563;6217.191765070512;6272.341404152681;6287.654179020198;6308.044506202908;6204.72078756448;6212.099245609271;6231.470325022424;6260.365670896048;6261.651880544796;6232.844178895564;6379.425851673372;6449.193850768654;6452.483801295979;6460.289368169591;6204.7828326008375;6240.812775616739;6255.78104766331;6276.340984196594;6277.623342599459 23:22:56 INFO - PROCESS | 22908 | |5;yui.html;730.7880714592768;760.6653072648035;799.828036972051;818.7543736878937;856.297835774665;14228.573142805719;14550.781738273934;14568.344424500896;14573.417063317467;14655.706885862277;13471.528496502624;13485.932570337134;13497;13520.932395338034;13523.459061637548;663.5819433756726;786.3080489169523;814.9348052155814;815.3803109636659;817.2195553246665;808.5027707959621;808.8988876390451;811.6307080278489;815.1970309245388;816.302061737215;837.6021389839808;840.5083026429515;841.2344766262702;841.9663213471484;844.8901642786429;832.2094010689868;832.7127141136328;834.9896625083657;838.5220424358118;838.8951381077366;609.1137395090133;611.7797592866565;616.8334549671564;617.4658920034183;618.22412871846;13898.722025559533;14030.088044277089;14035.929820350935;14084.859151408456;14148.221847798366;14181.929090354482;14235.074720143157;14388;14468.421263149461;14636.926815365961;10997.285176463503;11040.834387484114;11101.72245693856;11223.887761122365;11342.206045576813;3843.846246150151;3870.825812838429;3937.330653788863;4024.637782599551;4035.1929614077303;55536.44463555353;55945.44054559443;57762;58049.12926306066;58123.70938145324;11037.889621103846;11079.833802492969;11156.888431115585;11239.775204496027;11314.717132071764;20163.193472260944;20233.08951097204;20233.797662023193;20300.898495507725;20315.492112697302;8415.326773858076;8469.74590762278;8673.566321683891;8843.734687959372;8953.418027828171;4558.475775285885;4600.838970636079;4619.1685496610935;4731.929021064687;4775.761211939389;3454.7063499602314;3515.31451366981;3555.6799888010205;3562.2341196642847;3579.821008949594;651.5211319680031;656.0880376276979;662.3045801907978;663.0683889135772;700.4361489001403;675.2100042949761;686.5743239191734;735.4153448008846;747.9738209162762;757.5379018798528;9021.458712477272;9234.307426942873;9686.70939871805;10029.247806414402;10089.445080520642;756.1191212237682;757.3865169212955;763.9847203055908;769;783.627776806024;4703.482616912137;4732.432108147044;4773.236282194832;4773.93293666354;4787.784549695202;67849.66075169691;68930.31069689339;69874.30125698679;70214.64892675607;70275.64862175657;62038.37961620326;62648.68675656593;62696.373036269055;63233.36766632367;64757;54847.451525485034;55333.72333138389;55797;56193;58047.419525805046;8638.136186381564;8780.253678437404;8834.249088827522;8927;8929.553522323988;34532.48201277033;34951.650483495854;35239.82380088083;35411.114722131126;35617;39759.403608946464;41249.381259281734;41829.37255941102;43241;45135.774321128185;12107.273563586214;12113.878861211275;12125.939370303446;12500.187487813264;12654.177478463871;13698.794518082435;13723.1079979801;13753.243571603658;13981;14564.781528276872;12374.13381063317;12754.234745915275;12769.553065642658;13172.407241673956;13557.983151263497;13067.542636007694;13268.668283292995;13281.468741250243;13352.599422017354;13709.383077761326;12277.631671049883;12620.05349598802;12747.9164271038;13332.93333533326;13382.598522044354;10648;10822.567097316334;10829.350238985686;10990.230683852054;11081.833772493257;10901.34591924487;11008.669739907815;11119.555217791521;11148.777024459303;11171.38557379352 23:22:56 INFO - PROCESS | 22908 | __end_tp_report 23:22:56 INFO - PROCESS | 22908 | __start_cc_report 23:22:56 INFO - PROCESS | 22908 | _x_x_mozilla_cycle_collect,335 23:22:56 INFO - PROCESS | 22908 | __end_cc_report 23:22:56 INFO - PROCESS | 22908 | __startTimestamp1460182976467__endTimestamp 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | ------- Summary: start ------- 23:22:56 INFO - PROCESS | 22908 | Number of tests: 6 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#0] dojo.html Cycles:165 Average:5416.65 Median:5650.60 stddev:623.26 (11.0%) stddev-sans-first:598.85 23:22:56 INFO - PROCESS | 22908 | Values: 3132.0 3178.7 3203.2 3228.5 3230.4 5426.2 5469.9 5473.8 5482.9 5492.9 5327.9 5412.8 5450.0 5473.7 5534.3 4895.2 4911.9 4975.4 5005.9 5048.9 4923.0 4956.9 4993.8 5002.6 5057.2 4886.4 4893.6 4924.6 4930.5 4970.4 4906.7 4939.5 4950.6 4955.9 5001.6 4825.0 4900.9 4905.5 4932.6 4970.3 5277.6 5296.9 5332.8 5346.0 5350.7 5758.1 5761.4 5761.8 5767.0 5778.5 5664.8 5816.2 5832.7 5837.7 5861.9 5476.8 5483.5 5483.7 5484.8 5531.6 5924.1 5967.9 5969.4 5969.8 5987.6 5526.6 5690.2 5692.4 5704.9 5747.5 5816.9 5821.4 5826.7 5828.4 5833.5 5654.1 5728.3 5794.7 5873.0 5908.4 5762.9 5782.7 5830.9 5831.4 5843.6 4412.2 4412.8 4415.6 4439.5 4470.8 3934.4 3936.8 3940.6 3962.3 3971.2 5600.6 5628.8 5642.7 5650.6 5686.3 5853.3 5880.6 5918.6 5928.7 5936.5 5650.1 5652.3 5653.1 5660.0 5660.4 4777.2 4851.0 4886.3 4890.6 4913.0 6037.8 6069.2 6081.6 6092.1 6092.3 5891.7 5894.7 5896.4 5896.6 5905.9 5947.3 6047.7 6066.3 6090.1 6128.0 5720.7 5730.3 5732.9 5739.3 5740.8 5834.9 5849.8 5855.4 5862.9 5864.4 5542.5 5775.6 5797.7 5815.5 5845.7 5609.4 5689.5 5730.1 5740.6 5774.2 5548.2 5600.7 5619.3 5620.6 5623.4 5688.5 5726.5 5731.6 5737.1 5796.0 5584.6 5597.9 5607.9 5624.7 5628.7 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#1] ext.html Cycles:180 Average:53766.99 Median:385367.00 stddev:99160.90 (25.7%) stddev-sans-first:99358.76 23:22:56 INFO - PROCESS | 22908 | Values: 611.0 642.3 655.3 663.9 690.2 35872.1 36678.0 36844.8 36986.8 37042.3 37183.3 37559.8 37896.0 37933.8 38013.8 8286.2 8380.4 8432.5 8446.7 8467.2 8090.5 8365.1 8371.0 8371.7 8390.6 8587.8 8598.1 8657.3 8666.1 8708.1 8549.2 8569.4 8609.4 8621.1 8646.9 8484.2 8545.2 8571.7 8575.7 8580.1 34483.3 37009.4 37343.0 37488.0 37622.0 3376.3 3446.5 3535.3 3561.9 3577.8 29208.0 29444.6 29974.9 30206.7 30576.7 4254.7 4283.2 4295.8 4323.6 4327.2 279410.0 288356.0 288648.0 288893.0 289758.0 63540.0 63653.4 64008.7 64053.4 64097.4 67262.0 68507.7 68557.3 68573.0 68830.0 16172.5 16307.6 16317.8 16334.4 16360.5 13392.8 13397.3 13475.9 13490.8 13534.6 20575.5 20747.6 20783.0 20808.0 21000.9 7657.3 7694.8 7763.0 7952.6 7979.7 997.7 1063.1 1064.9 1101.6 1112.2 30382.5 30709.7 31172.2 31878.0 32046.8 1108.7 1127.8 1157.6 1212.8 1232.2 16105.4 16118.3 16614.3 16759.5 16762.7 432128.0 436938.0 438258.0 438979.0 442558.0 55808.7 56146.9 56151.0 56317.0 56628.2 1403.7 1415.5 1431.1 1451.1 1458.5 29877.4 30231.8 30422.5 30924.0 30977.5 48113.8 49809.3 49999.0 50174.2 50249.5 384467.0 386267.0 387720.0 387737.0 388373.0 28465.7 28671.4 28932.7 29220.3 29280.3 41484.6 41560.0 43601.3 46204.8 47063.3 39350.4 39358.2 39486.8 39770.2 40848.8 37892.0 39126.6 39182.0 39305.0 40091.6 40267.0 40536.6 40764.4 40805.6 41092.6 32340.8 33295.8 33668.6 34299.0 34318.3 27305.3 27329.6 27534.6 27559.6 27821.4 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#2] jquery.html Cycles:180 Average:29392.82 Median:15258.10 stddev:81395.93 (533.5%) stddev-sans-first:81595.14 23:22:56 INFO - PROCESS | 22908 | Values: 394.9 400.6 401.7 407.4 410.3 14542.6 17933.8 18609.5 18684.4 18687.0 17619.2 17810.1 18124.7 18520.0 18543.5 5094.1 5239.8 5482.5 5864.9 5873.4 5725.7 5773.4 5785.3 5785.8 5797.0 5747.0 6520.7 6866.0 6890.5 6894.3 6695.7 6834.0 7181.4 7183.5 7196.7 6632.2 6877.9 6903.8 6978.6 7063.6 23079.4 23201.5 23722.2 24450.7 25694.0 2450.8 2635.5 2665.7 2681.6 2938.5 15698.1 15719.2 15899.8 16072.8 16097.8 2054.6 2120.9 2134.3 2198.6 2217.5 88588.6 89856.0 92087.0 92337.5 93052.5 16684.7 16766.9 17212.2 17223.2 17511.5 14512.0 15342.7 31054.0 31328.2 31453.5 7892.9 8023.7 8042.3 8126.9 8202.3 7458.8 7620.7 7670.4 7694.3 7993.6 4422.2 4510.9 4730.9 4818.4 4871.8 2046.4 2048.4 2054.7 2059.7 2067.4 912.6 961.1 1023.7 1045.9 1128.8 16451.1 18591.9 18594.6 18945.5 19009.5 962.6 989.0 1003.8 1022.0 1032.2 10414.4 10787.1 10791.9 10799.0 10911.2 485157.0 487647.0 498796.0 499263.0 500111.0 85428.6 87387.6 87505.0 88250.6 88912.0 1040.8 1049.9 1052.3 1052.7 1065.5 16384.7 16556.4 16685.7 16868.6 17080.7 27577.7 35356.8 37520.6 37547.1 38890.2 48446.8 48466.8 48772.0 49678.5 50069.7 8420.0 8470.5 8654.9 8766.0 8777.4 12317.2 12977.9 13162.6 13223.8 13244.7 11174.9 11334.5 11442.5 11533.7 11668.4 11244.0 11464.3 11514.7 11521.7 11583.5 7221.6 9207.6 11635.3 11855.8 11864.1 8478.4 8541.4 8697.4 8812.0 8814.8 11218.3 11379.7 11413.7 11467.1 11526.4 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#3] mootools.html Cycles:180 Average:5885.19 Median:5094.72 stddev:3090.40 (60.7%) stddev-sans-first:3081.55 23:22:56 INFO - PROCESS | 22908 | Values: 1507.7 1540.5 1635.9 1761.1 1770.9 7341.3 8076.4 8077.4 8359.7 8385.4 8162.8 8206.5 8218.5 8252.4 8288.8 2353.7 2366.1 2394.4 2395.0 2400.3 2326.2 2349.0 2350.5 2351.9 2352.4 2274.3 2279.0 2285.0 2301.9 2306.8 2220.6 2250.8 2251.2 2256.3 2268.3 2268.8 2274.6 2279.5 2279.9 2286.4 8275.7 8358.7 8384.2 8398.1 8405.2 4939.8 5030.2 5092.4 5092.7 5113.9 3209.0 3210.8 3251.2 3290.2 3296.6 1123.6 1130.3 1134.7 1142.9 1158.7 11472.6 11543.7 11570.9 11609.7 11621.6 4438.7 4530.6 4562.0 4589.4 4600.9 9592.8 9711.0 9768.3 9796.0 9808.2 5012.1 5037.3 5066.5 5072.3 5096.7 4146.9 4630.9 4684.6 4733.2 4739.3 3902.1 3919.1 4025.6 4029.5 4108.4 1226.6 1228.9 1234.1 1237.7 1244.0 1374.3 1377.4 1404.2 1414.1 1423.1 7972.3 8052.6 8103.5 8143.7 8168.9 1038.6 1082.1 1122.7 1154.5 1166.7 6213.5 6318.5 6384.3 6401.6 6401.8 9578.7 10216.8 10265.7 10319.9 10336.6 9961.4 10257.8 10276.7 10378.2 10436.9 7765.2 7789.0 7793.1 7806.2 7861.2 7613.3 7703.5 7712.9 8003.9 8011.7 9306.9 9414.2 9424.5 9525.5 9618.3 9393.9 9573.8 9658.6 9766.5 9873.8 6826.7 7155.5 7316.5 7445.7 7614.2 8055.2 8074.3 8081.3 8111.4 8135.8 7159.1 7390.6 7396.9 7428.9 7509.9 6962.8 6970.4 6975.1 7063.3 7281.5 7618.8 7667.0 7702.8 7759.0 7793.3 7033.6 7039.9 7113.7 7114.9 7147.6 7166.1 7168.7 7241.5 7249.3 7260.7 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#4] prototype.html Cycles:180 Average:5237.21 Median:5992.95 stddev:1579.49 (26.4%) stddev-sans-first:1540.57 23:22:56 INFO - PROCESS | 22908 | Values: 340.7 341.8 347.0 353.0 354.4 5957.7 5964.4 5988.6 6002.8 6074.1 5858.9 5899.4 5900.2 5925.8 5929.6 4267.6 4504.0 4512.9 4518.5 4538.7 4481.9 4491.5 4495.4 4512.6 4516.6 4492.5 4494.4 4506.5 4541.5 4573.4 4441.0 4452.6 4482.1 4491.3 4495.2 3894.0 3896.9 3917.5 3922.1 3932.2 5643.4 5654.3 5701.5 5737.4 5753.4 4925.7 5202.2 5203.9 5225.2 5285.5 6149.3 6194.6 6214.4 6254.5 6275.0 4259.2 4260.9 4303.2 4307.3 4311.5 6203.6 6390.8 6561.3 6570.2 6600.7 4491.5 4530.9 4532.5 4533.1 4543.8 4531.8 4566.7 4574.7 4596.6 4597.3 5000.5 5250.8 5258.1 5280.2 5304.7 6277.8 6339.7 6349.8 6350.4 6356.2 1563.2 1572.7 1581.0 1585.8 1591.6 1015.5 1054.5 1059.3 1062.1 1076.7 5935.5 5939.6 6041.5 6045.2 6048.5 6424.5 6453.4 6453.5 6459.5 6465.6 5827.6 5997.3 6011.5 6012.7 6023.2 3404.0 3426.9 3453.5 3462.9 3465.7 6490.8 6572.3 6613.4 6623.6 6629.0 6360.2 6401.3 6454.0 6459.5 6492.7 6479.9 6608.2 6611.2 6615.5 6624.3 6284.2 6370.3 6384.9 6414.7 6441.9 6159.0 6234.2 6322.3 6324.4 6328.6 6788.8 6810.0 6813.0 6838.6 6855.7 4360.1 4384.8 4406.7 4414.6 4418.4 6326.6 6505.0 6542.7 6562.6 6635.2 6238.1 6247.3 6322.4 6362.6 6426.5 6070.4 6217.2 6272.3 6287.7 6308.0 6204.7 6212.1 6231.5 6260.4 6261.7 6232.8 6379.4 6449.2 6452.5 6460.3 6204.8 6240.8 6255.8 6276.3 6277.6 23:22:56 INFO - PROCESS | 22908 | 23:22:56 INFO - PROCESS | 22908 | [#5] yui.html Cycles:180 Average:15560.05 Median:44188.39 stddev:18600.82 (42.1%) stddev-sans-first:18619.67 23:22:56 INFO - PROCESS | 22908 | Values: 730.8 760.7 799.8 818.8 856.3 14228.6 14550.8 14568.3 14573.4 14655.7 13471.5 13485.9 13497.0 13520.9 13523.5 663.6 786.3 814.9 815.4 817.2 808.5 808.9 811.6 815.2 816.3 837.6 840.5 841.2 842.0 844.9 832.2 832.7 835.0 838.5 838.9 609.1 611.8 616.8 617.5 618.2 13898.7 14030.1 14035.9 14084.9 14148.2 14181.9 14235.1 14388.0 14468.4 14636.9 10997.3 11040.8 11101.7 11223.9 11342.2 3843.8 3870.8 3937.3 4024.6 4035.2 55536.4 55945.4 57762.0 58049.1 58123.7 11037.9 11079.8 11156.9 11239.8 11314.7 20163.2 20233.1 20233.8 20300.9 20315.5 8415.3 8469.7 8673.6 8843.7 8953.4 4558.5 4600.8 4619.2 4731.9 4775.8 3454.7 3515.3 3555.7 3562.2 3579.8 651.5 656.1 662.3 663.1 700.4 675.2 686.6 735.4 748.0 757.5 9021.5 9234.3 9686.7 10029.2 10089.4 756.1 757.4 764.0 769.0 783.6 4703.5 4732.4 4773.2 4773.9 4787.8 67849.7 68930.3 69874.3 70214.6 70275.6 62038.4 62648.7 62696.4 63233.4 64757.0 54847.5 55333.7 55797.0 56193.0 58047.4 8638.1 8780.3 8834.2 8927.0 8929.6 34532.5 34951.7 35239.8 35411.1 35617.0 39759.4 41249.4 41829.4 43241.0 45135.8 12107.3 12113.9 12125.9 12500.2 12654.2 13698.8 13723.1 13753.2 13981.0 14564.8 12374.1 12754.2 12769.6 13172.4 13558.0 13067.5 13268.7 13281.5 13352.6 13709.4 12277.6 12620.1 12747.9 13332.9 13382.6 10648.0 10822.6 10829.4 10990.2 11081.8 10901.3 11008.7 11119.6 11148.8 11171.4 23:22:56 INFO - PROCESS | 22908 | -------- Summary: end -------- 23:22:56 INFO - PROCESS | 22908 | 23:22:57 INFO - TEST-INFO | 22908: exit 0 23:22:57 INFO - TEST-OK | dromaeo_css | took 1110079ms 23:22:57 INFO - TEST-START | kraken 23:22:57 INFO - operating with platform_type : linux_ 23:22:57 INFO - Initialising browser for kraken test... 23:22:57 INFO - TEST-INFO | started process 23145 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTkUtql/profile http://localhost:39663/getInfo.html) 23:23:00 INFO - PROCESS | 23145 | 23:23:00 INFO - PROCESS | 23145 | (process:23212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:23:01 INFO - PROCESS | 23145 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 23:23:01 INFO - PROCESS | 23145 | __metrics Screen width/height:1600/1200 23:23:01 INFO - PROCESS | 23145 | colorDepth:24 23:23:01 INFO - PROCESS | 23145 | Browser inner width/height: 1024/697 23:23:01 INFO - PROCESS | 23145 | __metrics 23:23:02 ERROR - PROCESS | 23145 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 23:23:03 INFO - TEST-INFO | 23145: exit 0 23:23:03 INFO - Browser initialized. 23:23:03 INFO - Running cycle 1/1 for kraken test... 23:23:03 INFO - TEST-INFO | started process 23263 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTkUtql/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:04 INFO - PROCESS | 23263 | 23:23:04 INFO - PROCESS | 23263 | (process:23322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:23:14 INFO - PROCESS | 23263 | RSS: Main: 163573760 23:23:14 INFO - PROCESS | 23263 | 23:23:17 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39663/tests/kraken/driver.html?testName=audio-beat-detection) 23:23:18 INFO - PROCESS | 23263 | RSS: Main: 168206336 23:23:18 INFO - PROCESS | 23263 | 23:23:20 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39663/tests/kraken/driver.html?testName=audio-dft) 23:23:21 INFO - PROCESS | 23263 | RSS: Main: 170967040 23:23:21 INFO - PROCESS | 23263 | 23:23:24 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39663/tests/kraken/driver.html?testName=audio-fft) 23:23:24 INFO - PROCESS | 23263 | RSS: Main: 162181120 23:23:24 INFO - PROCESS | 23263 | 23:23:26 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39663/tests/kraken/driver.html?testName=audio-oscillator) 23:23:27 INFO - PROCESS | 23263 | RSS: Main: 163467264 23:23:27 INFO - PROCESS | 23263 | 23:23:29 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:23:30 INFO - PROCESS | 23263 | RSS: Main: 163307520 23:23:30 INFO - PROCESS | 23263 | 23:23:33 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39663/tests/kraken/driver.html?testName=imaging-darkroom) 23:23:34 INFO - PROCESS | 23263 | RSS: Main: 163409920 23:23:34 INFO - PROCESS | 23263 | 23:23:37 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39663/tests/kraken/driver.html?testName=imaging-desaturate) 23:23:38 INFO - PROCESS | 23263 | RSS: Main: 163655680 23:23:38 INFO - PROCESS | 23263 | 23:23:40 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39663/tests/kraken/driver.html?testName=json-parse-financial) 23:23:41 INFO - PROCESS | 23263 | RSS: Main: 165879808 23:23:41 INFO - PROCESS | 23263 | 23:23:43 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:23:43 INFO - PROCESS | 23263 | RSS: Main: 165908480 23:23:43 INFO - PROCESS | 23263 | 23:23:45 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:23:45 INFO - PROCESS | 23263 | RSS: Main: 166551552 23:23:45 INFO - PROCESS | 23263 | 23:23:48 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:23:48 INFO - PROCESS | 23263 | RSS: Main: 166604800 23:23:48 INFO - PROCESS | 23263 | 23:23:51 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:23:51 INFO - PROCESS | 23263 | RSS: Main: 167305216 23:23:51 INFO - PROCESS | 23263 | 23:23:54 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:23:55 INFO - PROCESS | 23263 | RSS: Main: 166572032 23:23:55 INFO - PROCESS | 23263 | 23:23:56 INFO - PROCESS | 23263 | Cycle 1(1): loaded http://localhost:39663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39663/tests/kraken/driver.html?testName=ai-astar) 23:23:57 INFO - PROCESS | 23263 | RSS: Main: 168435712 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | __start_tp_report 23:23:57 INFO - PROCESS | 23263 | _x_x_mozilla_page_load 23:23:57 INFO - PROCESS | 23263 | _x_x_mozilla_page_load_details 23:23:57 INFO - PROCESS | 23263 | |i|pagename|runs| 23:23:57 INFO - PROCESS | 23263 | |0;ai-astar;111;106;114;112;114;123;112;111;112;115 23:23:57 INFO - PROCESS | 23263 | |1;audio-beat-detection;152;127;151;174;133;156;161;131;172;128 23:23:57 INFO - PROCESS | 23263 | |2;audio-dft;162;161;162;162;163;161;162;165;169;163 23:23:57 INFO - PROCESS | 23263 | |3;audio-fft;74;76;72;74;73;76;72;75;141;78 23:23:57 INFO - PROCESS | 23263 | |4;audio-oscillator;94;98;147;94;96;93;140;92;94;148 23:23:57 INFO - PROCESS | 23263 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 23:23:57 INFO - PROCESS | 23263 | |6;imaging-darkroom;147;147;147;147;147;147;148;146;149;147 23:23:57 INFO - PROCESS | 23263 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;96 23:23:57 INFO - PROCESS | 23263 | |8;json-parse-financial;62;62;58;60;59;58;59;60;57;56 23:23:57 INFO - PROCESS | 23263 | |9;json-stringify-tinderbox;63;63;64;64;63;67;64;63;63;63 23:23:57 INFO - PROCESS | 23263 | |10;stanford-crypto-aes;81;80;88;81;80;80;80;88;81;80 23:23:57 INFO - PROCESS | 23263 | |11;stanford-crypto-ccm;136;141;127;128;130;132;136;134;134;128 23:23:57 INFO - PROCESS | 23263 | |12;stanford-crypto-pbkdf2;166;166;175;168;168;163;165;166;163;173 23:23:57 INFO - PROCESS | 23263 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;69;70;68;68;70 23:23:57 INFO - PROCESS | 23263 | __end_tp_report 23:23:57 INFO - PROCESS | 23263 | __start_cc_report 23:23:57 INFO - PROCESS | 23263 | _x_x_mozilla_cycle_collect,850 23:23:57 INFO - PROCESS | 23263 | __end_cc_report 23:23:57 INFO - PROCESS | 23263 | __startTimestamp1460183037200__endTimestamp 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | ------- Summary: start ------- 23:23:57 INFO - PROCESS | 23263 | Number of tests: 14 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.29 (3.8%) stddev-sans-first:4.49 23:23:57 INFO - PROCESS | 23263 | Values: 111.0 106.0 114.0 112.0 114.0 123.0 112.0 111.0 112.0 115.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:154.00 stddev:17.83 (11.6%) stddev-sans-first:18.87 23:23:57 INFO - PROCESS | 23263 | Values: 152.0 127.0 151.0 174.0 133.0 156.0 161.0 131.0 172.0 128.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.40 (1.5%) stddev-sans-first:2.52 23:23:57 INFO - PROCESS | 23263 | Values: 162.0 161.0 162.0 162.0 163.0 161.0 162.0 165.0 169.0 163.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:21.13 (28.4%) stddev-sans-first:22.26 23:23:57 INFO - PROCESS | 23263 | Values: 74.0 76.0 72.0 74.0 73.0 76.0 72.0 75.0 141.0 78.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.00 stddev:24.57 (26.1%) stddev-sans-first:25.40 23:23:57 INFO - PROCESS | 23263 | Values: 94.0 98.0 147.0 94.0 96.0 93.0 140.0 92.0 94.0 148.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:23:57 INFO - PROCESS | 23263 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:23:57 INFO - PROCESS | 23263 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 149.0 147.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:23:57 INFO - PROCESS | 23263 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.50 stddev:1.97 (3.3%) stddev-sans-first:1.79 23:23:57 INFO - PROCESS | 23263 | Values: 62.0 62.0 58.0 60.0 59.0 58.0 59.0 60.0 57.0 56.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 23:23:57 INFO - PROCESS | 23263 | Values: 63.0 63.0 64.0 64.0 63.0 67.0 64.0 63.0 63.0 63.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:3.25 (4.0%) stddev-sans-first:3.43 23:23:57 INFO - PROCESS | 23263 | Values: 81.0 80.0 88.0 81.0 80.0 80.0 80.0 88.0 81.0 80.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:134.00 stddev:4.45 (3.3%) stddev-sans-first:4.55 23:23:57 INFO - PROCESS | 23263 | Values: 136.0 141.0 127.0 128.0 130.0 132.0 136.0 134.0 134.0 128.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:3.95 (2.4%) stddev-sans-first:4.16 23:23:57 INFO - PROCESS | 23263 | Values: 166.0 166.0 175.0 168.0 168.0 163.0 165.0 166.0 163.0 173.0 23:23:57 INFO - PROCESS | 23263 | 23:23:57 INFO - PROCESS | 23263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 23:23:57 INFO - PROCESS | 23263 | Values: 67.0 68.0 68.0 68.0 67.0 69.0 70.0 68.0 68.0 70.0 23:23:57 INFO - PROCESS | 23263 | -------- Summary: end -------- 23:23:57 INFO - PROCESS | 23263 | 23:23:58 INFO - TEST-INFO | 23263: exit 0 23:23:58 INFO - TEST-OK | kraken | took 60972ms 23:23:58 INFO - SUITE-END | took 1171s 23:23:58 INFO - Completed test suite (00:19:31) 23:23:58 INFO - javascript benchmark 23:23:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.9821058156103, 3178.745700343972, 3203.19920019995, 3228.5318628798823, 3230.3862266169426, 5426.21319908613, 5469.917951230735, 5473.781048758045, 5482.862928426786, 5492.862678433031, 5327.946720532803, 5412.810551630694, 5450.04624190767, 5473.67157970522, 5534.335879694432, 4895.2412376081675, 4911.852644420673, 4975.402951645808, 5005.874853128665, 5048.899022019576, 4922.950770492303, 4956.900861982776, 4993.75031248438, 5002.574781143607, 5057.241413787924, 4886.389201349832, 4893.608511319086, 4924.60603151747, 4930.457649658535, 4970.353853998993, 4906.730129842857, 4939.506049395068, 4950.554450099472, 4955.925661115086, 5001.624878134155, 4824.951750482485, 4900.901981960376, 4905.460399356068, 4932.556069953722, 4970.279309500138, 5277.604179686539, 5296.947030529684, 5332.786688532493, 5346.03771321162, 5350.705711185883, 5758.1362795581, 5761.395053519362, 5761.798337058183, 5767.048437007888, 5778.537716982673, 5664.773409063632, 5816.243888294537, 5832.737526811304, 5837.708114594296, 5861.88276234473, 5476.780928762844, 5483.506484416422, 5483.725813709299, 5484.808031718871, 5531.612787104904, 5924.052151655715, 5967.940320596826, 5969.432903874125, 5969.76120955157, 5987.580869339192, 5526.640768350125, 5690.2033715279895, 5692.37383887772, 5704.885902282014, 5747.511461525817, 5816.912746308809, 5821.359650438449, 5826.6795326256615, 5828.417158284223, 5833.533317334603, 5654.095344744821, 5728.341240757283, 5794.710264486759, 5873.0, 5908.350081491032, 5762.88474230513, 5782.710864456844, 5830.912536311958, 5831.358550559435, 5843.649381037151, 4412.2499175139665, 4412.801423935931, 4415.646748260131, 4439.511653718088, 4470.8435204767675, 3934.449177115206, 3936.842526298973, 3940.566537680853, 3962.32640451124, 3971.225611005884, 5600.60795744294, 5628.774849006076, 5642.661440313512, 5650.604457688005, 5686.2607860977805, 5853.326867410302, 5880.588358814842, 5918.644881307136, 5928.7332070056955, 5936.495397891142, 5650.124230744241, 5652.3217213934595, 5653.095504719226, 5660.037793575019, 5660.433956604306, 4777.163996300634, 4850.95149048505, 4886.315915771795, 4890.559849613552, 4913.041956818458, 6037.758489660452, 6069.211002569726, 6081.5742897996715, 6092.116643086816, 6092.268927728701, 5891.705414729161, 5894.734736936934, 5896.351401345934, 5896.616719913192, 5905.881882362242, 5947.256592925884, 6047.667378294236, 6066.3023752269055, 6090.086487026804, 6127.988881834447, 5720.656760594377, 5730.3410107838135, 5732.942670573408, 5739.339975902824, 5740.827775166752, 5834.912476312774, 5849.824505264849, 5855.3559108497175, 5862.94137058624, 5864.384239654775, 5542.473465020817, 5775.624584402, 5797.739101740347, 5815.534757219497, 5845.707714614337, 5609.382967873612, 5689.487946084872, 5730.111832665943, 5740.569457290637, 5774.249347584787, 5548.195511650707, 5600.663960162403, 5619.297587801525, 5620.634658747332, 5623.437656234344, 5688.544916406595, 5726.513246374105, 5731.598788084794, 5737.08206686928, 5796.0, 5584.609077364546, 5597.860053498533, 5607.943920560742, 5624.74688639004, 5628.690422026828], "value": 5374.307572102072, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.9572329936904, 642.2710223895879, 655.2530115668136, 663.9468842492599, 690.1993687322706, 35872.103197420074, 36678.0, 36844.81577592112, 36986.81506592463, 37042.25915481692, 37183.25633487335, 37559.81220093903, 37896.0, 37933.81033094838, 38013.80993095031, 8286.212809783075, 8380.371472139583, 8432.494050356998, 8446.662133514683, 8467.237948584627, 8090.514569125871, 8365.12166222544, 8371.037330706955, 8371.748847534584, 8390.622421991025, 8587.828243435128, 8598.097199794025, 8657.307415406784, 8666.133386661346, 8708.129187081304, 8549.187827156411, 8569.357298202629, 8609.440386374865, 8621.13788621139, 8646.913530864675, 8484.236418722283, 8545.188207120314, 8571.699990500303, 8575.656973721043, 8580.141985801432, 34483.31033379344, 37009.444858327144, 37343.0, 37488.0, 37622.0, 3376.3416133853907, 3446.5174875517446, 3535.3106144301873, 3561.910952226215, 3577.8032208228537, 29208.0, 29444.55833162504, 29974.85012574945, 30206.69793302061, 30576.69423305783, 4254.7021708480415, 4283.164782867342, 4295.806688699016, 4323.589259020388, 4327.156204540116, 279410.0, 288356.0, 288648.0, 288893.0, 289758.0, 63540.0, 63653.363466364746, 64008.67995660085, 64053.35946640474, 64097.35902641007, 67262.0, 68507.65746171237, 68557.3144268551, 68573.0, 68830.0, 16172.514824555283, 16307.59231019234, 16317.755233671505, 16334.428295009619, 16360.509184724477, 13392.799108013387, 13397.330133493286, 13475.932620336836, 13490.797638035438, 13534.59396218115, 20575.485612859797, 20747.585048298948, 20783.0, 20808.0, 21000.894995525232, 7657.272559106876, 7694.846103077907, 7762.961185194038, 7952.558427673603, 7979.680812767424, 997.6857289953641, 1063.134199479908, 1064.914806815453, 1101.581399068349, 1112.249231768553, 30382.54426183609, 30709.69290307068, 31172.220694482818, 31878.0, 32046.83976580102, 1108.6507750058706, 1127.7969965406305, 1157.6179860645966, 1212.8423304970297, 1232.168286406672, 16105.436309729103, 16118.274677639534, 16614.252358643647, 16759.497215083567, 16762.74855877163, 432128.0, 436938.0, 438258.0, 438979.0, 442558.0, 55808.72095639577, 56146.87706245852, 56151.0, 56317.0, 56628.15057774137, 1403.7052219034117, 1415.4762737787084, 1431.0698046270008, 1451.1438251431705, 1458.4749490183738, 29877.402451950406, 30231.769586724076, 30422.543661844647, 30924.0, 30977.535336970413, 48113.75943120262, 49809.25286120638, 49999.0, 50174.2473862885, 50249.49750502448, 384467.0, 386267.0, 387720.0, 387737.0, 388373.0, 28465.715342847136, 28671.42657146887, 28932.710672893, 29220.26949326284, 29280.26799330034, 41484.58515414807, 41560.0, 43601.34597981096, 46204.768976154905, 47063.294050588585, 39350.40974385329, 39358.21283574255, 39486.80256598699, 39770.204595907344, 40848.79575602103, 37892.0, 39126.6087339123, 39182.0, 39305.0, 40091.59908400878, 40267.0, 40536.59463405328, 40764.38853417142, 40805.59194408018, 41092.589074110074, 32340.83829580837, 33295.83689549489, 33668.59504544794, 34299.0, 34318.31363372769, 27305.31736706598, 27329.590056148776, 27534.586981195698, 27559.586606201323, 27821.44357112806], "value": 19531.230860391734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8894309593313, 400.64542879551607, 401.7388697346722, 407.4377359244243, 410.2512913932073, 14542.636434089127, 17933.82066179338, 18609.53476163095, 18684.439466815984, 18686.97221652812, 17619.207135678895, 17810.109494525288, 18124.728129078074, 18520.0, 18543.536411589717, 5094.133997220472, 5239.816606418776, 5482.533984611313, 5864.941350586503, 5873.412658734113, 5725.713714314288, 5773.364929857712, 5785.27684039495, 5785.8264252072295, 5797.0, 5746.994276001704, 6520.706568204442, 6865.965670171642, 6890.517663763539, 6894.345037221481, 6695.732170713166, 6834.0, 7181.425485961111, 7183.533070350462, 7196.712131514733, 6632.204135503722, 6877.862442751167, 6903.75836845713, 6978.581285122909, 7063.6115013674225, 23079.423014424607, 23201.53596928052, 23722.169724059746, 24450.699155613944, 25694.0, 2450.82844200906, 2635.472905418924, 2665.6667916510437, 2681.5977603359456, 2938.471075206462, 15698.136602486858, 15719.214039297989, 15899.761503577456, 16072.75890861638, 16097.758533621887, 2054.5685406064745, 2120.8759357540375, 2134.263679030732, 2198.604251234777, 2217.545403192342, 88588.55705721494, 89855.99999999935, 92087.0, 92337.53831230868, 93052.53473732655, 16684.74972875408, 16766.916165419094, 17212.225449854788, 17223.22495487706, 17511.474655760347, 14512.0, 15342.69587085088, 31054.0, 31328.21679458032, 31453.528197077063, 7892.894994700747, 8023.679052837938, 8042.276195142465, 8126.918730812735, 8202.302804261586, 7458.813529661802, 7620.657070431844, 7670.4247181461615, 7694.307512323918, 7993.560354180576, 4422.226110430726, 4510.864674059783, 4730.8711080013445, 4818.445878723922, 4871.8294859679745, 2046.3656266557414, 2048.416201382599, 2054.7123402723632, 2059.7013433052125, 2067.4211220858183, 912.6258234123977, 961.0965692249264, 1023.7287118913493, 1045.895410458948, 1128.7629597784558, 16451.095189764437, 18591.907040464983, 18594.628107437777, 18945.526361840788, 19009.524761881064, 962.605331813953, 988.980220395588, 1003.8243307421318, 1021.97445063874, 1032.1691038713757, 10414.35829864534, 10787.137029037658, 10791.892081079246, 10799.028087472165, 10911.181661375269, 485157.0, 487647.0, 498796.0, 499263.0, 500111.0, 85428.57285713656, 87387.56306218555, 87505.0, 88250.55874720713, 88912.0, 1040.8022475729588, 1049.8897615750236, 1052.305478384278, 1052.7105046112226, 1065.4725910674265, 16384.67230655404, 16556.42052528156, 16685.66628667444, 16868.57828554296, 17080.65838683244, 27577.724222757515, 35356.76251331191, 37520.6247937528, 37547.06132346604, 38890.22219555536, 48446.75776621094, 48466.757666211444, 48772.0, 49678.503214968834, 50069.74965125151, 8420.0, 8470.534120623179, 8654.913450865412, 8766.0357360689, 8777.435733418713, 12317.199382040139, 12977.935110324388, 13162.60512184636, 13223.801642975171, 13244.735105298032, 11174.88825111771, 11334.489947952527, 11442.48508817122, 11533.653990380302, 11668.358240296866, 11244.0, 11464.25482343645, 11514.712132196762, 11521.654350369503, 11583.478743456397, 7221.602811845399, 9207.631694732403, 11635.301881887113, 11855.822162667395, 11864.11019173548, 8478.364122690946, 8541.359398045295, 8697.434666746642, 8812.030676625438, 8814.823703525766, 11218.270812397168, 11379.715507112389, 11413.714657133638, 11467.139964502529, 11526.366049867338], "value": 9634.843128538476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.7210716017537, 1540.48393788081, 1635.9100249486273, 1761.0578340587788, 1770.9291628334868, 7341.339279464847, 8076.3538916886655, 8077.353811695065, 8359.749207523777, 8385.413021088527, 8162.795930101751, 8206.548639824807, 8218.54797986112, 8252.381071419637, 8288.792780180498, 2353.6587194856734, 2366.065404165354, 2394.449276666368, 2394.95210095798, 2400.2919138853995, 2326.2439707095177, 2348.988255058731, 2350.529894021194, 2351.870647114408, 2352.3648614873973, 2274.3290729234914, 2279.0, 2285.0174424997244, 2301.884905754714, 2306.7808558186944, 2220.609001770119, 2250.7861753133507, 2251.2120757734824, 2256.334381357495, 2268.3421807675754, 2268.7844654757773, 2274.636058230675, 2279.452931296477, 2279.908803647852, 2286.3826766773045, 8275.668973241063, 8358.707445239448, 8384.161583841627, 8398.076211616717, 8405.159484051606, 4939.827106051271, 5030.170021946375, 5092.414372347191, 5092.719900405476, 5113.872153196163, 3208.983955080233, 3210.7752457327997, 3251.1872031992, 3290.226796702773, 3296.620888597818, 1123.606737641827, 1130.327455164176, 1134.7049767060541, 1142.8914253145938, 1158.7161145519317, 11472.598459053977, 11543.711407214887, 11570.94214528922, 11609.6517104487, 11621.605407351002, 4438.689291749546, 4530.614897733663, 4561.977190114028, 4589.403377560962, 4600.907981840344, 9592.76018099553, 9710.951445242728, 9768.316217864682, 9796.0, 9808.21534277256, 5012.072766538202, 5037.319961805109, 5066.46802085783, 5072.315237442972, 5096.719680417613, 4146.854860079943, 4630.884227894329, 4684.625229981593, 4733.219018861918, 4739.312799644102, 3902.1415288636454, 3919.0594257378025, 4025.577314382006, 4029.4560234368573, 4108.4453598764385, 1226.6320103968774, 1228.8648248692637, 1234.0682784497646, 1237.7215126596443, 1244.0, 1374.3197117426937, 1377.435251546861, 1404.1996062244423, 1414.0949792133042, 1423.110555902561, 7972.2824945755165, 8052.637631306605, 8103.513789172668, 8143.674253029931, 8168.9183108169345, 1038.6364772329623, 1082.123479981202, 1122.6912599035168, 1154.5151036564496, 1166.7374840660784, 6213.502919766408, 6318.48356394462, 6384.32964538726, 6401.64790936503, 6401.839954001094, 9578.664746733832, 10216.795664086676, 10265.692029239135, 10319.896801032044, 10336.586536538454, 9961.402315860927, 10257.794844103077, 10276.691699249035, 10378.169746420268, 10436.947815260875, 7765.184655611192, 7789.026371703537, 7793.103793063757, 7806.18035106317, 7861.174576669482, 7613.276738709814, 7703.537787732754, 7712.884306735516, 8003.91996080055, 8011.719589814328, 9306.92970308396, 9414.2468602513, 9424.528773561158, 9525.476098814632, 9618.326717129734, 9393.906060939304, 9573.760655983377, 9658.613655453702, 9766.462844543334, 9873.753156171153, 6826.658667066527, 7155.534890232118, 7316.487845850952, 7445.739399121005, 7614.238576142341, 8055.1944805521325, 8074.313683336747, 8081.313088387553, 8111.391645626483, 8135.75592732219, 7159.140903091662, 7390.630468476447, 7396.852062958603, 7428.851422971402, 7509.9249007509225, 6962.756303529352, 6970.442364610921, 6975.058367120374, 7063.328983746535, 7281.526700764433, 7618.771436856903, 7667.0, 7702.845943081219, 7759.0, 7793.337566306701, 7033.613151276729, 7039.894401583878, 7113.679884405317, 7114.893276600958, 7147.571145731273, 7166.104236970379, 7168.677409516688, 7241.5293005954445, 7249.275072492708, 7260.67326970277], "value": 4811.732473576826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6644455211616, 341.8478776944259, 347.0, 352.9611742708303, 354.43113802347233, 5957.731902064406, 5964.373740757218, 5988.580799344048, 6002.759889604411, 6074.149619053325, 5858.853528661775, 5899.410058994098, 5900.232969713942, 5925.762969481227, 5929.614575052629, 4267.551907049761, 4503.954960450386, 4512.9097418051615, 4518.5481451854885, 4538.727676339414, 4481.932771008437, 4491.505934347219, 4495.370648109268, 4512.616427603642, 4516.593506584407, 4492.505824359318, 4494.37078808967, 4506.52681468446, 4541.500434952152, 4573.359729637853, 4440.955590444087, 4452.621527170194, 4482.050308115964, 4491.348754430622, 4495.168393847116, 3894.0264933766557, 3896.883093507199, 3917.4907262056036, 3922.0783115967724, 3932.1518886123476, 5643.40744221859, 5654.349749778746, 5701.54610574305, 5737.426257374271, 5753.367129615781, 4925.704457732548, 5202.167653175474, 5203.947960520422, 5225.242339860737, 5285.471452854684, 6149.262088549358, 6194.628322300631, 6214.378562143795, 6254.530910181755, 6275.0, 4259.190753756776, 4260.893477663052, 4303.182395344875, 4307.289297265947, 4311.461067366579, 6203.596766210182, 6390.840228994266, 6561.311062338434, 6570.244421891448, 6600.702968366387, 4491.528389519053, 4530.886727831765, 4532.501424843264, 4533.138703646297, 4543.750093744876, 4531.773411329486, 4566.725996440225, 4574.6569007323915, 4596.5863072323655, 4597.333386658983, 5000.524950129732, 5250.823251932526, 5258.079836028756, 5280.234366016906, 5304.655197412233, 6277.811665650038, 6339.714712837934, 6349.841253968595, 6350.396712312323, 6356.237251529754, 1563.1558958162693, 1572.701186774509, 1580.9604759880865, 1585.7542080977466, 1591.6498370358502, 1015.5277795824977, 1054.514923135351, 1059.2902755154066, 1062.1131355318396, 1076.6608518316705, 5935.52515798735, 5939.584229103922, 6041.5468839837185, 6045.21412216409, 6048.459646948292, 6424.453921416732, 6453.354664533509, 6453.548251622436, 6459.547831651833, 6465.579737317059, 5827.59206855516, 5997.310309314485, 6011.458968692838, 6012.699365031731, 6023.216981792339, 3404.0, 3426.9205200361807, 3453.5292031508175, 3462.9480557791653, 3465.70541503975, 6490.772822951174, 6572.277049524549, 6613.437857782143, 6623.635700036448, 6629.0, 6360.173177486897, 6401.295857455676, 6454.0, 6459.547831651833, 6492.67536623167, 6479.870402591921, 6608.2400523939405, 6611.173603299588, 6615.470762339001, 6624.304448032984, 6284.24589049317, 6370.267419246846, 6384.9042264367, 6414.711337989895, 6441.935580644321, 6158.967540711644, 6234.1583886174785, 6322.292980895225, 6324.430801227912, 6328.6202827830475, 6788.830279243059, 6809.994653929259, 6812.956113166129, 6838.555493892881, 6855.6572171390235, 4360.127974405068, 4384.780760962003, 4406.669499787465, 4414.646828253668, 4418.403515525363, 6326.588771729823, 6505.0, 6542.738290468328, 6562.606243625398, 6635.203775546772, 6238.095476156022, 6247.281562620356, 6322.430981211529, 6362.586431881913, 6426.518011149276, 6070.423309785563, 6217.191765070512, 6272.341404152681, 6287.654179020198, 6308.044506202908, 6204.72078756448, 6212.099245609271, 6231.470325022424, 6260.365670896048, 6261.651880544796, 6232.844178895564, 6379.425851673372, 6449.193850768654, 6452.483801295979, 6460.289368169591, 6204.7828326008375, 6240.812775616739, 6255.78104766331, 6276.340984196594, 6277.623342599459], "value": 4727.442086718607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7880714592768, 760.6653072648035, 799.828036972051, 818.7543736878937, 856.297835774665, 14228.573142805719, 14550.781738273934, 14568.344424500896, 14573.417063317467, 14655.706885862277, 13471.528496502624, 13485.932570337134, 13497.0, 13520.932395338034, 13523.459061637548, 663.5819433756726, 786.3080489169523, 814.9348052155814, 815.3803109636659, 817.2195553246665, 808.5027707959621, 808.8988876390451, 811.6307080278489, 815.1970309245388, 816.302061737215, 837.6021389839808, 840.5083026429515, 841.2344766262702, 841.9663213471484, 844.8901642786429, 832.2094010689868, 832.7127141136328, 834.9896625083657, 838.5220424358118, 838.8951381077366, 609.1137395090133, 611.7797592866565, 616.8334549671564, 617.4658920034183, 618.22412871846, 13898.722025559533, 14030.088044277089, 14035.929820350935, 14084.859151408456, 14148.221847798366, 14181.929090354482, 14235.074720143157, 14388.0, 14468.421263149461, 14636.926815365961, 10997.285176463503, 11040.834387484114, 11101.72245693856, 11223.887761122365, 11342.206045576813, 3843.846246150151, 3870.825812838429, 3937.330653788863, 4024.637782599551, 4035.1929614077303, 55536.44463555353, 55945.44054559443, 57762.0, 58049.12926306066, 58123.70938145324, 11037.889621103846, 11079.833802492969, 11156.888431115585, 11239.775204496027, 11314.717132071764, 20163.193472260944, 20233.08951097204, 20233.797662023193, 20300.898495507725, 20315.492112697302, 8415.326773858076, 8469.74590762278, 8673.566321683891, 8843.734687959372, 8953.418027828171, 4558.475775285885, 4600.838970636079, 4619.1685496610935, 4731.929021064687, 4775.761211939389, 3454.7063499602314, 3515.31451366981, 3555.6799888010205, 3562.2341196642847, 3579.821008949594, 651.5211319680031, 656.0880376276979, 662.3045801907978, 663.0683889135772, 700.4361489001403, 675.2100042949761, 686.5743239191734, 735.4153448008846, 747.9738209162762, 757.5379018798528, 9021.458712477272, 9234.307426942873, 9686.70939871805, 10029.247806414402, 10089.445080520642, 756.1191212237682, 757.3865169212955, 763.9847203055908, 769.0, 783.627776806024, 4703.482616912137, 4732.432108147044, 4773.236282194832, 4773.93293666354, 4787.784549695202, 67849.66075169691, 68930.31069689339, 69874.30125698679, 70214.64892675607, 70275.64862175657, 62038.37961620326, 62648.68675656593, 62696.373036269055, 63233.36766632367, 64757.0, 54847.451525485034, 55333.72333138389, 55797.0, 56193.0, 58047.419525805046, 8638.136186381564, 8780.253678437404, 8834.249088827522, 8927.0, 8929.553522323988, 34532.48201277033, 34951.650483495854, 35239.82380088083, 35411.114722131126, 35617.0, 39759.403608946464, 41249.381259281734, 41829.37255941102, 43241.0, 45135.774321128185, 12107.273563586214, 12113.878861211275, 12125.939370303446, 12500.187487813264, 12654.177478463871, 13698.794518082435, 13723.1079979801, 13753.243571603658, 13981.0, 14564.781528276872, 12374.13381063317, 12754.234745915275, 12769.553065642658, 13172.407241673956, 13557.983151263497, 13067.542636007694, 13268.668283292995, 13281.468741250243, 13352.599422017354, 13709.383077761326, 12277.631671049883, 12620.05349598802, 12747.9164271038, 13332.93333533326, 13382.598522044354, 10648.0, 10822.567097316334, 10829.350238985686, 10990.230683852054, 11081.833772493257, 10901.34591924487, 11008.669739907815, 11119.555217791521, 11148.777024459303, 11171.38557379352], "value": 6918.080779344621, "unit": "score"}], "name": "dromaeo_css", "value": 7361.6447747208495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 114.0, 112.0, 114.0, 123.0, 112.0, 111.0, 112.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 151.0, 174.0, 133.0, 156.0, 161.0, 131.0, 172.0, 128.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 165.0, 169.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 72.0, 74.0, 73.0, 76.0, 72.0, 75.0, 141.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 147.0, 94.0, 96.0, 93.0, 140.0, 92.0, 94.0, 148.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 149.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 58.0, 60.0, 59.0, 58.0, 59.0, 60.0, 57.0, 56.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 63.0, 67.0, 64.0, 63.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 88.0, 81.0, 80.0, 80.0, 80.0, 88.0, 81.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 127.0, 128.0, 130.0, 132.0, 136.0, 134.0, 134.0, 128.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 175.0, 168.0, 168.0, 163.0, 165.0, 166.0, 163.0, 173.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 70.0, 68.0, 68.0, 70.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1548.1, "alertThreshold": 2.0}]} 23:23:58 INFO - Return code: 0 23:23:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:23:58 ERROR - # TBPL SUCCESS # 23:23:58 INFO - Running post-action listener: _resource_record_post_action 23:23:58 INFO - Running post-run listener: _resource_record_post_run 23:23:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 538415104; Read time: 0; Write time: 425536 23:23:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249774080; Read time: 0; Write time: 263920 23:23:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 288641024; Read time: 0; Write time: 161616 23:23:59 INFO - Running post-run listener: _upload_blobber_files 23:23:59 INFO - Blob upload gear active. 23:23:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:23:59 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 23:23:59 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:23:59 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:24:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:00 INFO - (blobuploader) - INFO - Done attempting. 23:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:01 INFO - (blobuploader) - INFO - Done attempting. 23:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 23:24:01 INFO - Return code: 0 23:24:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293cadc2c83d98d19123b2468f839cbf3c11bcd0c3530bd496147dc0f69992d109749a26bd5ac7ada7a072571da12d921d41c9ded6522e55e6b4ac6fb756016", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93737994cb356172446d6c94647b995ed305ccee7016252624b1b38489b0b1ac9c6c1b6e67e7457587d57fd263e0c67302a36d8962c9c5d946087abecde5ed11"} 23:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:24:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:24:01 INFO - Contents: 23:24:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293cadc2c83d98d19123b2468f839cbf3c11bcd0c3530bd496147dc0f69992d109749a26bd5ac7ada7a072571da12d921d41c9ded6522e55e6b4ac6fb756016", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93737994cb356172446d6c94647b995ed305ccee7016252624b1b38489b0b1ac9c6c1b6e67e7457587d57fd263e0c67302a36d8962c9c5d946087abecde5ed11"} 23:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 23:24:01 INFO - Copying logs to upload dir... 23:24:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.573545 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-08 23:24:01.378475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 23:24:01.382056) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293cadc2c83d98d19123b2468f839cbf3c11bcd0c3530bd496147dc0f69992d109749a26bd5ac7ada7a072571da12d921d41c9ded6522e55e6b4ac6fb756016", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93737994cb356172446d6c94647b995ed305ccee7016252624b1b38489b0b1ac9c6c1b6e67e7457587d57fd263e0c67302a36d8962c9c5d946087abecde5ed11"} build_url:https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/WPpGx1UbS8WHXqLF9IEohA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293cadc2c83d98d19123b2468f839cbf3c11bcd0c3530bd496147dc0f69992d109749a26bd5ac7ada7a072571da12d921d41c9ded6522e55e6b4ac6fb756016", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93737994cb356172446d6c94647b995ed305ccee7016252624b1b38489b0b1ac9c6c1b6e67e7457587d57fd263e0c67302a36d8962c9c5d946087abecde5ed11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 23:24:01.411833) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:24:01.412404) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460180348.888781-906464005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 23:24:01.494085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 23:24:01.494432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 23:24:01.494899) ========= ========= Total master_lag: 0.37 =========