builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1458604194.62 results: success (0) buildid: 20160321141720 builduid: a64a2f12df7f4c74ab094234fbdde118 revision: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.622804) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.623240) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.623690) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006408 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.660567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.660850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.692426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.692696) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.748002) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.748282) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.748619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.748888) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 16:49:54-- 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% 82.3M=0s 2016-03-21 16:49:55 (82.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.925385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.925737) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022183 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.976455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:54.976770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 --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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 16:49:55,119 truncating revision to first 12 chars 2016-03-21 16:49:55,119 Setting DEBUG logging. 2016-03-21 16:49:55,119 attempt 1/10 2016-03-21 16:49:55,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5edaa5a69616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 16:49:55,384 unpacking tar archive at: mozilla-aurora-5edaa5a69616/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:55.569984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:55.570332) ========= echo 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5edaa5a69616d6aa6d1cb7f540f1bad734d96977'] 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 program finished with exit code 0 elapsedTime=0.004857 script_repo_revision: '5edaa5a69616d6aa6d1cb7f540f1bad734d96977' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:55.634583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:55.634888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 16:49:55.674224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-21 16:49:55.674613) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:55 INFO - MultiFileLogger online at 20160321 16:49:55 in /builds/slave/test-pgo 16:49:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:49:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:49:55 INFO - {'append_to_log': False, 16:49:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:49:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:49:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:49:55 INFO - 'branch': 'Mozilla-Aurora', 16:49:55 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:55 INFO - 'config_files': ('talos/linux_config.py',), 16:49:55 INFO - 'default_actions': ('clobber', 16:49:55 INFO - 'read-buildbot-config', 16:49:55 INFO - 'download-and-extract', 16:49:55 INFO - 'populate-webroot', 16:49:55 INFO - 'create-virtualenv', 16:49:55 INFO - 'install', 16:49:55 INFO - 'run-tests'), 16:49:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:55 INFO - 'download_minidump_stackwalk': True, 16:49:55 INFO - 'download_symbols': 'ondemand', 16:49:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:55 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:55 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:55 INFO - 'installer_path': 'installer.exe', 16:49:55 INFO - 'log_level': 'info', 16:49:55 INFO - 'log_name': 'talos', 16:49:55 INFO - 'log_to_console': True, 16:49:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:55 INFO - 'opt_config_files': (), 16:49:55 INFO - 'pip_index': False, 16:49:55 INFO - 'sps_profile': False, 16:49:55 INFO - 'sps_profile_interval': 0, 16:49:55 INFO - 'suite': 'dromaeojs-e10s', 16:49:55 INFO - 'system_bits': '32', 16:49:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:55 INFO - 'title': 'talos-linux64-ix-047', 16:49:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:55 INFO - 'use_talos_json': True, 16:49:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:49:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:55 INFO - 'work_dir': 'build'} 16:49:55 INFO - ##### 16:49:55 INFO - ##### Running clobber step. 16:49:55 INFO - ##### 16:49:55 INFO - Running pre-action listener: _resource_record_pre_action 16:49:55 INFO - Running main action method: clobber 16:49:55 INFO - rmtree: /builds/slave/test-pgo/build 16:49:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:49:56 INFO - Running post-action listener: _resource_record_post_action 16:49:56 INFO - ##### 16:49:56 INFO - ##### Running read-buildbot-config step. 16:49:56 INFO - ##### 16:49:56 INFO - Running pre-action listener: _resource_record_pre_action 16:49:56 INFO - Running main action method: read_buildbot_config 16:49:56 INFO - Using buildbot properties: 16:49:56 INFO - { 16:49:56 INFO - "project": "", 16:49:56 INFO - "product": "firefox", 16:49:56 INFO - "script_repo_revision": "production", 16:49:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:49:56 INFO - "repository": "", 16:49:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:49:56 INFO - "buildid": "20160321141720", 16:49:56 INFO - "pgo_build": "True", 16:49:56 INFO - "basedir": "/builds/slave/test-pgo", 16:49:56 INFO - "buildnumber": 205, 16:49:56 INFO - "slavename": "talos-linux64-ix-047", 16:49:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:49:56 INFO - "platform": "ubuntu64_hw", 16:49:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:49:56 INFO - "branch": "mozilla-aurora", 16:49:56 INFO - "repo_path": "releases/mozilla-aurora", 16:49:56 INFO - "revision": "5edaa5a69616d6aa6d1cb7f540f1bad734d96977", 16:49:56 INFO - "stage_platform": "linux64-pgo", 16:49:56 INFO - "builduid": "a64a2f12df7f4c74ab094234fbdde118", 16:49:56 INFO - "slavebuilddir": "test" 16:49:56 INFO - } 16:49:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:49:56 INFO - Running post-action listener: _resource_record_post_action 16:49:56 INFO - ##### 16:49:56 INFO - ##### Running download-and-extract step. 16:49:56 INFO - ##### 16:49:56 INFO - Running pre-action listener: _resource_record_pre_action 16:49:56 INFO - Running main action method: download_and_extract 16:49:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:49: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')]} 16:49:56 INFO - https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:50:00 INFO - Downloaded 1448 bytes. 16:50:00 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:50:00 INFO - Using the following test package requirements: 16:50:00 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:50:00 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:00 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:50:00 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'jsshell-linux-x86_64.zip'], 16:50:00 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:00 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:50:00 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:50:00 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:50:00 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:00 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:50:00 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:50:00 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:00 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:00 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')]} 16:50:00 INFO - https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:01 INFO - Downloaded 23310135 bytes. 16:50:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:02 INFO - Return code: 0 16:50:02 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:02 INFO - https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:13 INFO - Downloaded 23310135 bytes. 16:50:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:14 INFO - Return code: 0 16:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:14 INFO - https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:50:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:50:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:50:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:16 INFO - Downloaded 10845161 bytes. 16:50:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:17 INFO - Return code: 0 16:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:17 INFO - https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:26 INFO - Downloaded 60450489 bytes. 16:50:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:50:26 INFO - mkdir: /builds/slave/test-pgo/properties 16:50:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:50:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:50:26 INFO - Contents: 16:50:26 INFO - build_url:https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - Running post-action listener: set_extra_try_arguments 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running populate-webroot step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: populate_webroot 16:50:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:27 INFO - '--tppagecycles', 16:50:27 INFO - '7'], 16:50:27 INFO - 'tests': ['tsvgm']}}, 16:50:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:50:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:50:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'tests': ['damp', 'tps']}, 16:50:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['damp', 'tps']}, 16:50:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:50:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:27 INFO - 'other': {'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'other_l64': {'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'other_nol64': {'tests': ['a11yr', 16:50:27 INFO - 'ts_paint', 16:50:27 INFO - 'tpaint', 16:50:27 INFO - 'sessionrestore', 16:50:27 INFO - 'sessionrestore_no_auto_restore', 16:50:27 INFO - 'tabpaint']}, 16:50:27 INFO - 'svgr': {'tests': ['tsvgx', 16:50:27 INFO - 'tsvgr_opacity', 16:50:27 INFO - 'tart', 16:50:27 INFO - 'tscrollx', 16:50:27 INFO - 'cart']}, 16:50:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['tsvgx', 16:50:27 INFO - 'tsvgr_opacity', 16:50:27 INFO - 'tart', 16:50:27 INFO - 'tscrollx', 16:50:27 INFO - 'cart']}, 16:50:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'tests': ['tp5o']}, 16:50:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'talos_options': ['--e10s'], 16:50:27 INFO - 'tests': ['tp5o']}, 16:50:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'talos_options': ['--xperf_path', 16:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:27 INFO - 'tests': ['tp5n']}, 16:50:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:27 INFO - 'talos_options': ['--e10s', 16:50:27 INFO - '--xperf_path', 16:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:27 INFO - 'tests': ['tp5n']}}, 16:50:27 INFO - 'talos.zip': {'path': '', 16:50:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running create-virtualenv step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: create_virtualenv 16:50:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:50:27 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 16:50:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:50:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:27 INFO - Using real prefix '/usr' 16:50:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:50:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:29 INFO - Installing pip.................done. 16:50:29 INFO - Return code: 0 16:50:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:50:29 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')]} 16:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:29 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')]} 16:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:29 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:29 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 16:50:29 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 16:50:29 INFO - Using env: {'DISPLAY': ':0', 16:50:29 INFO - 'HOME': '/home/cltbld', 16:50:29 INFO - 'LANG': 'en_US.UTF-8', 16:50:29 INFO - 'LANGUAGE': 'en_US:en', 16:50:29 INFO - 'LOGNAME': 'cltbld', 16:50:29 INFO - 'MAIL': '/var/mail/cltbld', 16:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:29 INFO - 'MOZ_NO_REMOTE': '1', 16:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:29 INFO - 'NO_EM_RESTART': '1', 16:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:29 INFO - 'SHELL': '/bin/bash', 16:50:29 INFO - 'SHLVL': '1', 16:50:29 INFO - 'TERM': 'linux', 16:50:29 INFO - 'TMOUT': '86400', 16:50:29 INFO - 'USER': 'cltbld', 16:50:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:29 INFO - '_': '/tools/buildbot/bin/python'} 16:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:29 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 16:50:29 INFO - Cleaning up... 16:50:29 INFO - Return code: 0 16:50:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:50:29 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')]} 16:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:29 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')]} 16:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:29 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:29 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 16:50:29 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 16:50:29 INFO - Using env: {'DISPLAY': ':0', 16:50:29 INFO - 'HOME': '/home/cltbld', 16:50:29 INFO - 'LANG': 'en_US.UTF-8', 16:50:29 INFO - 'LANGUAGE': 'en_US:en', 16:50:29 INFO - 'LOGNAME': 'cltbld', 16:50:29 INFO - 'MAIL': '/var/mail/cltbld', 16:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:29 INFO - 'MOZ_NO_REMOTE': '1', 16:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:29 INFO - 'NO_EM_RESTART': '1', 16:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:29 INFO - 'SHELL': '/bin/bash', 16:50:29 INFO - 'SHLVL': '1', 16:50:29 INFO - 'TERM': 'linux', 16:50:29 INFO - 'TMOUT': '86400', 16:50:29 INFO - 'USER': 'cltbld', 16:50:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:29 INFO - '_': '/tools/buildbot/bin/python'} 16:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:30 INFO - Downloading/unpacking psutil>=0.7.1 16:50:30 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 16:50:30 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 16:50:30 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 16:50:30 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 16:50:30 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 16:50:30 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 16:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:32 INFO - Installing collected packages: psutil 16:50:32 INFO - Running setup.py install for psutil 16:50:32 INFO - building 'psutil._psutil_linux' extension 16:50:32 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 16:50:32 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 16:50:32 INFO - building 'psutil._psutil_posix' extension 16:50:32 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 16:50:32 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 16:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:32 INFO - Successfully installed psutil 16:50:32 INFO - Cleaning up... 16:50:32 INFO - Return code: 0 16:50:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:50:32 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')]} 16:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:32 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')]} 16:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:32 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:32 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 16:50:32 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 16:50:32 INFO - Using env: {'DISPLAY': ':0', 16:50:32 INFO - 'HOME': '/home/cltbld', 16:50:32 INFO - 'LANG': 'en_US.UTF-8', 16:50:32 INFO - 'LANGUAGE': 'en_US:en', 16:50:32 INFO - 'LOGNAME': 'cltbld', 16:50:32 INFO - 'MAIL': '/var/mail/cltbld', 16:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:32 INFO - 'MOZ_NO_REMOTE': '1', 16:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:32 INFO - 'NO_EM_RESTART': '1', 16:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:32 INFO - 'SHELL': '/bin/bash', 16:50:32 INFO - 'SHLVL': '1', 16:50:32 INFO - 'TERM': 'linux', 16:50:32 INFO - 'TMOUT': '86400', 16:50:32 INFO - 'USER': 'cltbld', 16:50:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:32 INFO - '_': '/tools/buildbot/bin/python'} 16:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:50:32 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 16:50:32 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 16:50:32 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 16:50:32 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 16:50:32 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 16:50:32 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 16:50:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:50:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:50:35 INFO - Installing collected packages: mozsystemmonitor 16:50:35 INFO - Running setup.py install for mozsystemmonitor 16:50:35 INFO - Successfully installed mozsystemmonitor 16:50:35 INFO - Cleaning up... 16:50:35 INFO - Return code: 0 16:50:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:50:35 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')]} 16:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:35 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')]} 16:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:35 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:35 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 16:50:35 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 16:50:35 INFO - Using env: {'DISPLAY': ':0', 16:50:35 INFO - 'HOME': '/home/cltbld', 16:50:35 INFO - 'LANG': 'en_US.UTF-8', 16:50:35 INFO - 'LANGUAGE': 'en_US:en', 16:50:35 INFO - 'LOGNAME': 'cltbld', 16:50:35 INFO - 'MAIL': '/var/mail/cltbld', 16:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:35 INFO - 'MOZ_NO_REMOTE': '1', 16:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:35 INFO - 'NO_EM_RESTART': '1', 16:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:35 INFO - 'SHELL': '/bin/bash', 16:50:35 INFO - 'SHLVL': '1', 16:50:35 INFO - 'TERM': 'linux', 16:50:35 INFO - 'TMOUT': '86400', 16:50:35 INFO - 'USER': 'cltbld', 16:50:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:35 INFO - '_': '/tools/buildbot/bin/python'} 16:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:35 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 16:50:35 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 16:50:35 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 16:50:35 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 16:50:35 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 16:50:35 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 16:50:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:50:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:50:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:50:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:38 INFO - Downloading docopt-0.6.1.tar.gz 16:50:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:50:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:50:38 INFO - Running setup.py install for blobuploader 16:50:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:50:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:50:38 INFO - Running setup.py install for requests 16:50:39 INFO - Running setup.py install for docopt 16:50:39 INFO - Successfully installed blobuploader requests docopt 16:50:39 INFO - Cleaning up... 16:50:39 INFO - Return code: 0 16:50:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:39 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:39 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 16:50:39 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 16:50:39 INFO - Using env: {'DISPLAY': ':0', 16:50:39 INFO - 'HOME': '/home/cltbld', 16:50:39 INFO - 'LANG': 'en_US.UTF-8', 16:50:39 INFO - 'LANGUAGE': 'en_US:en', 16:50:39 INFO - 'LOGNAME': 'cltbld', 16:50:39 INFO - 'MAIL': '/var/mail/cltbld', 16:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:39 INFO - 'MOZ_NO_REMOTE': '1', 16:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:39 INFO - 'NO_EM_RESTART': '1', 16:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:39 INFO - 'SHELL': '/bin/bash', 16:50:39 INFO - 'SHLVL': '1', 16:50:39 INFO - 'TERM': 'linux', 16:50:39 INFO - 'TMOUT': '86400', 16:50:39 INFO - 'USER': 'cltbld', 16:50:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:39 INFO - '_': '/tools/buildbot/bin/python'} 16:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:39 INFO - Running setup.py (path:/tmp/pip-7V1DhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:39 INFO - Running setup.py (path:/tmp/pip-884JFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:39 INFO - Running setup.py (path:/tmp/pip-AEsSn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:39 INFO - Running setup.py (path:/tmp/pip-ZUQXzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:39 INFO - Running setup.py (path:/tmp/pip-Ogy2Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:39 INFO - Running setup.py (path:/tmp/pip-bFJbR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:39 INFO - Running setup.py (path:/tmp/pip-IxZr5Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:40 INFO - Running setup.py (path:/tmp/pip-H5PXaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:40 INFO - Running setup.py (path:/tmp/pip-GoYHZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:40 INFO - Running setup.py (path:/tmp/pip-RAIYwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:40 INFO - Running setup.py (path:/tmp/pip-ki3VEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:40 INFO - Running setup.py (path:/tmp/pip-QfZjeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:40 INFO - Running setup.py (path:/tmp/pip-M_vFnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:40 INFO - Running setup.py (path:/tmp/pip-uramCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:40 INFO - Running setup.py (path:/tmp/pip-MCLDSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:40 INFO - Running setup.py (path:/tmp/pip-4pWOXn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:40 INFO - Running setup.py (path:/tmp/pip-2Z94cr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:40 INFO - Running setup.py install for manifestparser 16:50:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:50:40 INFO - Running setup.py install for mozcrash 16:50:40 INFO - Running setup.py install for mozdebug 16:50:41 INFO - Running setup.py install for mozdevice 16:50:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for mozfile 16:50:41 INFO - Running setup.py install for mozhttpd 16:50:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for mozinfo 16:50:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for mozInstall 16:50:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for mozleak 16:50:41 INFO - Running setup.py install for mozlog 16:50:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for moznetwork 16:50:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:50:41 INFO - Running setup.py install for mozprocess 16:50:42 INFO - Running setup.py install for mozprofile 16:50:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:50:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:50:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:50:42 INFO - Running setup.py install for mozrunner 16:50:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:50:42 INFO - Running setup.py install for mozscreenshot 16:50:42 INFO - Running setup.py install for moztest 16:50:42 INFO - Running setup.py install for mozversion 16:50:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:50:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:50:42 INFO - Cleaning up... 16:50:42 INFO - Return code: 0 16:50:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:42 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:42 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 16:50:42 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 16:50:42 INFO - Using env: {'DISPLAY': ':0', 16:50:42 INFO - 'HOME': '/home/cltbld', 16:50:42 INFO - 'LANG': 'en_US.UTF-8', 16:50:42 INFO - 'LANGUAGE': 'en_US:en', 16:50:42 INFO - 'LOGNAME': 'cltbld', 16:50:42 INFO - 'MAIL': '/var/mail/cltbld', 16:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:42 INFO - 'MOZ_NO_REMOTE': '1', 16:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:42 INFO - 'NO_EM_RESTART': '1', 16:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:42 INFO - 'SHELL': '/bin/bash', 16:50:42 INFO - 'SHLVL': '1', 16:50:42 INFO - 'TERM': 'linux', 16:50:42 INFO - 'TMOUT': '86400', 16:50:42 INFO - 'USER': 'cltbld', 16:50:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:42 INFO - '_': '/tools/buildbot/bin/python'} 16:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:42 INFO - Running setup.py (path:/tmp/pip-rR14vF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:42 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)) 16:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:42 INFO - Running setup.py (path:/tmp/pip-qwZkhq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:42 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)) 16:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:42 INFO - Running setup.py (path:/tmp/pip-u8iQVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:42 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)) 16:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:42 INFO - Running setup.py (path:/tmp/pip-oQMWIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:43 INFO - Running setup.py (path:/tmp/pip-Fc5Vio-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:43 INFO - Running setup.py (path:/tmp/pip-eblykL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:43 INFO - Running setup.py (path:/tmp/pip-zqQNwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:43 INFO - Running setup.py (path:/tmp/pip-0LfJf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:43 INFO - Running setup.py (path:/tmp/pip-GyLaHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:43 INFO - Running setup.py (path:/tmp/pip-FILWwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:43 INFO - Running setup.py (path:/tmp/pip-dybEWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:43 INFO - Running setup.py (path:/tmp/pip-BNidPz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:43 INFO - Running setup.py (path:/tmp/pip-XSU6Kg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:43 INFO - Running setup.py (path:/tmp/pip-qQRbCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:43 INFO - Running setup.py (path:/tmp/pip-V5YVaq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:43 INFO - Running setup.py (path:/tmp/pip-nDjSV4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:43 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)) 16:50:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:43 INFO - Running setup.py (path:/tmp/pip-qZihDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:44 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)) 16:50:44 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)) 16:50:44 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)) 16:50:44 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)) 16:50:44 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)) 16:50:44 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)) 16:50:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:44 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 16:50:44 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 16:50:44 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 16:50:44 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 16:50:44 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 16:50:44 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 16:50:46 INFO - Downloading blessings-1.6.tar.gz 16:50:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:50:46 INFO - Installing collected packages: blessings 16:50:46 INFO - Running setup.py install for blessings 16:50:46 INFO - Successfully installed blessings 16:50:46 INFO - Cleaning up... 16:50:46 INFO - Return code: 0 16:50:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:50:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:46 INFO - Reading from file tmpfile_stdout 16:50:46 INFO - Current package versions: 16:50:46 INFO - argparse == 1.2.1 16:50:46 INFO - blessings == 1.6 16:50:46 INFO - blobuploader == 1.2.4 16:50:46 INFO - docopt == 0.6.1 16:50:46 INFO - manifestparser == 1.1 16:50:46 INFO - mozInstall == 1.12 16:50:46 INFO - mozcrash == 0.17 16:50:46 INFO - mozdebug == 0.1 16:50:46 INFO - mozdevice == 0.48 16:50:46 INFO - mozfile == 1.2 16:50:46 INFO - mozhttpd == 0.7 16:50:46 INFO - mozinfo == 0.9 16:50:46 INFO - mozleak == 0.1 16:50:46 INFO - mozlog == 3.1 16:50:46 INFO - moznetwork == 0.27 16:50:46 INFO - mozprocess == 0.22 16:50:46 INFO - mozprofile == 0.28 16:50:46 INFO - mozrunner == 6.11 16:50:46 INFO - mozscreenshot == 0.1 16:50:46 INFO - mozsystemmonitor == 0.0 16:50:46 INFO - moztest == 0.7 16:50:46 INFO - mozversion == 1.4 16:50:46 INFO - psutil == 3.1.1 16:50:46 INFO - requests == 1.2.3 16:50:46 INFO - wsgiref == 0.1.2 16:50:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:46 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')]} 16:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:46 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')]} 16:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:46 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 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50:46 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 16:50:46 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 16:50:46 INFO - Using env: {'DISPLAY': ':0', 16:50:46 INFO - 'HOME': '/home/cltbld', 16:50:46 INFO - 'LANG': 'en_US.UTF-8', 16:50:46 INFO - 'LANGUAGE': 'en_US:en', 16:50:46 INFO - 'LOGNAME': 'cltbld', 16:50:46 INFO - 'MAIL': '/var/mail/cltbld', 16:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:46 INFO - 'MOZ_NO_REMOTE': '1', 16:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:46 INFO - 'NO_EM_RESTART': '1', 16:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:46 INFO - 'SHELL': '/bin/bash', 16:50:46 INFO - 'SHLVL': '1', 16:50:46 INFO - 'TERM': 'linux', 16:50:46 INFO - 'TMOUT': '86400', 16:50:46 INFO - 'USER': 'cltbld', 16:50:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:46 INFO - '_': '/tools/buildbot/bin/python'} 16:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 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)) 16:50:46 INFO - Cleaning up... 16:50:47 INFO - Return code: 0 16:50:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50: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', 'jsonschema'] in /builds/slave/test-pgo/build 16:50: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 jsonschema 16:50:47 INFO - Using env: {'DISPLAY': ':0', 16:50:47 INFO - 'HOME': '/home/cltbld', 16:50:47 INFO - 'LANG': 'en_US.UTF-8', 16:50:47 INFO - 'LANGUAGE': 'en_US:en', 16:50:47 INFO - 'LOGNAME': 'cltbld', 16:50:47 INFO - 'MAIL': '/var/mail/cltbld', 16:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:47 INFO - 'MOZ_NO_REMOTE': '1', 16:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:47 INFO - 'NO_EM_RESTART': '1', 16:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:47 INFO - 'SHELL': '/bin/bash', 16:50:47 INFO - 'SHLVL': '1', 16:50:47 INFO - 'TERM': 'linux', 16:50:47 INFO - 'TMOUT': '86400', 16:50:47 INFO - 'USER': 'cltbld', 16:50:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:47 INFO - '_': '/tools/buildbot/bin/python'} 16:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:47 INFO - Downloading/unpacking jsonschema 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:49 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:49 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 16:50:49 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 16:50:49 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 16:50:49 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 16:50:49 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 16:50:49 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 16:50:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:49 INFO - warning: no files found matching '*.txt' 16:50:49 INFO - no previously-included directories found matching 'build' 16:50:49 INFO - no previously-included directories found matching 'dist' 16:50:49 INFO - no previously-included directories found matching '.git*' 16:50:49 INFO - Installing collected packages: jsonschema, functools32 16:50:50 INFO - Running setup.py install for functools32 16:50:50 INFO - warning: no files found matching '*.txt' 16:50:50 INFO - no previously-included directories found matching 'build' 16:50:50 INFO - no previously-included directories found matching 'dist' 16:50:50 INFO - no previously-included directories found matching '.git*' 16:50:50 INFO - Successfully installed jsonschema functools32 16:50:50 INFO - Cleaning up... 16:50:50 INFO - Return code: 0 16:50:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e28c42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', '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 16:50: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', 'flake8'] in /builds/slave/test-pgo/build 16:50: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 flake8 16:50:50 INFO - Using env: {'DISPLAY': ':0', 16:50:50 INFO - 'HOME': '/home/cltbld', 16:50:50 INFO - 'LANG': 'en_US.UTF-8', 16:50:50 INFO - 'LANGUAGE': 'en_US:en', 16:50:50 INFO - 'LOGNAME': 'cltbld', 16:50:50 INFO - 'MAIL': '/var/mail/cltbld', 16:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:50 INFO - 'MOZ_NO_REMOTE': '1', 16:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:50 INFO - 'NO_EM_RESTART': '1', 16:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:50 INFO - 'SHELL': '/bin/bash', 16:50:50 INFO - 'SHLVL': '1', 16:50:50 INFO - 'TERM': 'linux', 16:50:50 INFO - 'TMOUT': '86400', 16:50:50 INFO - 'USER': 'cltbld', 16:50:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:50 INFO - '_': '/tools/buildbot/bin/python'} 16:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:50 INFO - Downloading/unpacking flake8 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:53 INFO - no previously-included directories found matching 'docs/_build' 16:50:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:53 INFO - Running setup.py install for pep8 16:50:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:53 INFO - no previously-included directories found matching 'docs/_build' 16:50:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:50:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:54 INFO - Cleaning up... 16:50:54 INFO - Return code: 0 16:50:54 INFO - Running post-action listener: _resource_record_post_action 16:50:54 INFO - Running post-action listener: _start_resource_monitoring 16:50:54 INFO - Starting resource monitoring. 16:50:54 INFO - ##### 16:50:54 INFO - ##### Running install step. 16:50:54 INFO - ##### 16:50:54 INFO - Running pre-action listener: _resource_record_pre_action 16:50:54 INFO - Running main action method: install 16:50:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:54 INFO - Reading from file tmpfile_stdout 16:50:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:50:54 INFO - Reading from file tmpfile_stdout 16:50:54 INFO - Output received: 16:50:54 INFO - Usage: mozinstall [options] installer 16:50:54 INFO - Options: 16:50:54 INFO - -h, --help show this help message and exit 16:50:54 INFO - -d DEST, --destination=DEST 16:50:54 INFO - Directory to install application into. [default: 16:50:54 INFO - "/builds/slave/test-pgo"] 16:50:54 INFO - --app=APP Application being installed. [default: firefox] 16:50:54 INFO - mkdir: /builds/slave/test-pgo/build/application 16:50:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:51:09 INFO - Reading from file tmpfile_stdout 16:51:09 INFO - Output received: 16:51:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:51:09 INFO - Running post-action listener: _resource_record_post_action 16:51:09 INFO - ##### 16:51:09 INFO - ##### Running run-tests step. 16:51:09 INFO - ##### 16:51:09 INFO - Running pre-action listener: _resource_record_pre_action 16:51:09 INFO - Running main action method: run_tests 16:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:51:09 INFO - Python 2.7.3 16:51:09 INFO - Return code: 0 16:51:09 INFO - grabbing minidump binary from tooltool 16:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:09 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 0x13a9920>, '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 0x13aa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aacb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:51:09 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 16:51:09 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 16:51:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:09 INFO - Return code: 0 16:51:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:51:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:51:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:51:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:51:10 INFO - Return code: 0 16:51:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 16:51:10 INFO - Using env: {'DISPLAY': ':0', 16:51:10 INFO - 'HOME': '/home/cltbld', 16:51:10 INFO - 'LANG': 'en_US.UTF-8', 16:51:10 INFO - 'LANGUAGE': 'en_US:en', 16:51:10 INFO - 'LOGNAME': 'cltbld', 16:51:10 INFO - 'MAIL': '/var/mail/cltbld', 16:51:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:10 INFO - 'MOZ_NO_REMOTE': '1', 16:51:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:10 INFO - 'NO_EM_RESTART': '1', 16:51:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:51:10 INFO - 'SHELL': '/bin/bash', 16:51:10 INFO - 'SHLVL': '1', 16:51:10 INFO - 'TERM': 'linux', 16:51:10 INFO - 'TMOUT': '86400', 16:51:10 INFO - 'USER': 'cltbld', 16:51:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405', 16:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:10 INFO - '_': '/tools/buildbot/bin/python'} 16:51:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:51:10 INFO - mozversion application_buildid: 20160321141720 16:51:10 INFO - mozversion application_changeset: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 16:51:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:51:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:10 INFO - mozversion application_name: Firefox 16:51:10 INFO - mozversion application_remotingname: firefox-dev 16:51:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:51:10 INFO - mozversion application_vendor: Mozilla 16:51:10 INFO - mozversion application_version: 47.0a2 16:51:10 INFO - mozversion platform_buildid: 20160321141720 16:51:10 INFO - mozversion platform_changeset: 5edaa5a69616d6aa6d1cb7f540f1bad734d96977 16:51:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:51:10 INFO - mozversion platform_version: 47.0a2 16:51:10 INFO - using testdate: 1458604270 16:51:10 INFO - actual date: 1458604270 16:51:10 INFO - starting webserver on 'localhost:33211' 16:51:10 INFO - SUITE-START | Running 2 tests 16:51:10 INFO - TEST-START | dromaeo_css 16:51:10 INFO - operating with platform_type : linux_ 16:51:10 INFO - Initialising browser for dromaeo_css test... 16:51:10 INFO - TEST-INFO | started process 4631 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgaiFE5/profile http://localhost:33211/getInfo.html) 16:51:14 INFO - PROCESS | 4631 | 16:51:14 INFO - PROCESS | 4631 | (process:4709): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:15 INFO - PROCESS | 4631 | __metrics Screen width/height:1600/1200 16:51:15 INFO - PROCESS | 4631 | colorDepth:24 16:51:15 INFO - PROCESS | 4631 | Browser inner width/height: 1024/697 16:51:15 INFO - PROCESS | 4631 | __metrics 16:51:16 ERROR - PROCESS | 4631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:51:17 INFO - TEST-INFO | 4631: exit 0 16:51:17 INFO - Browser initialized. 16:51:17 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:17 INFO - TEST-INFO | started process 4760 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgaiFE5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:18 INFO - PROCESS | 4760 | 16:51:18 INFO - PROCESS | 4760 | (process:4830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:28 INFO - PROCESS | 4760 | RSS: Main: 154476544 16:51:28 INFO - PROCESS | 4760 | 16:52:18 INFO - PROCESS | 4760 | 1458604338429 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:54:26 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33211/tests/dromaeo/cssquery-ext.html) 16:54:27 INFO - PROCESS | 4760 | RSS: Main: 157036544 16:54:27 INFO - PROCESS | 4760 | 16:57:29 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-ext.html (next: http://localhost:33211/tests/dromaeo/cssquery-jquery.html) 16:57:30 INFO - PROCESS | 4760 | RSS: Main: 156712960 16:57:30 INFO - PROCESS | 4760 | 17:00:31 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33211/tests/dromaeo/cssquery-mootools.html) 17:00:32 INFO - PROCESS | 4760 | RSS: Main: 155340800 17:00:32 INFO - PROCESS | 4760 | 17:03:33 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33211/tests/dromaeo/cssquery-prototype.html) 17:03:34 INFO - PROCESS | 4760 | RSS: Main: 155836416 17:03:34 INFO - PROCESS | 4760 | 17:06:36 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33211/tests/dromaeo/cssquery-yui.html) 17:06:37 INFO - PROCESS | 4760 | RSS: Main: 155521024 17:06:37 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | Cycle 1(1): loaded http://localhost:33211/tests/dromaeo/cssquery-yui.html (next: http://localhost:33211/tests/dromaeo/cssquery-dojo.html) 17:09:39 INFO - PROCESS | 4760 | RSS: Main: 158064640 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | __start_tp_report 17:09:39 INFO - PROCESS | 4760 | _x_x_mozilla_page_load 17:09:39 INFO - PROCESS | 4760 | _x_x_mozilla_page_load_details 17:09:39 INFO - PROCESS | 4760 | |i|pagename|runs| 17:09:39 INFO - PROCESS | 4760 | |0;dojo.html;3281.8194999275042;3329.9833500832524;3337.7830441021338;3375.662433756623;3377.071305391017;5439;5469.371022332433;5481.12302031675;5495.670259784406;5500.724963751816;5442.102053161234;5477.4796394342475;5499.092649712793;5505.697186654733;5513.58648101393;4989.176785830334;5035.798568057273;5078.5937125029905;5090.185570308751;5101.591872650198;5015.5736762375245;5104.157813960692;5110.182370820651;5115.53960143587;5122.206058061007;5055.39335279767;5097.668651537657;5106.744662766865;5108.157154069574;5141.974290128544;5111.13110771168;5122.487751224885;5137.434882162959;5152.768125434327;5154.4072431670465;4886.3403440535785;4888.951110488921;5131;5156.664816786897;5162.870928226786;5340.092184328673;5369.140937450028;5381.784728610851;5387.0841956867425;5395.676259424408;5880.912031274185;5916.822495325147;5918.644881307136;5925.140854576105;5936.228290322274;5944.316403613553;5950.137230101611;6015.518758499309;6021.969890150565;6056.96971515144;5541.836214394982;5594.216809646653;5601.915971260434;5608.887822243573;5613.607047506676;5917.437843404869;6051.4553690168095;6082.9695851520455;6103.6032657877095;6117.541184411098;5835.56233282497;5849.151872978395;5886.264216972879;5903.114532820111;5912.46787789101;5919;5922.407759224043;5926.851828704317;5927.3776253493625;5930.703464826827;5786.450287222707;5804.245448091806;5836.474717275466;5854.882902342015;5896.115582662549;5861.3552509223955;5903.380145084704;5903.498202652737;5918;5948.405159484104;4485.349624304457;4486.170058539181;4488.842890498817;4497.685162038626;4507.5943165115295;4026.5570787213383;4026.7382620129597;4043.433919251307;4066.186762647423;4099.036726369301;5532.336119665585;5538.529225015838;5628.746706398222;5639.661620302795;5647.237622920853;5985.9401405986255;6004.609700369462;6006.849828754316;6023.728932198062;6032.39676032402;5528.474794894479;5577.8047768327915;5652.434756524314;5703.030484817591;5709.029464990961;5014.2979982802435;5071.4928507149725;5084.288199652052;5096;5107.693538387709;6103.267607887082;6109.389061093855;6119.938800612026;6120.326764055951;6136.846578835565;5864.765409383577;5866.6186697864505;5961.582689211714;5979.4618484336615;5982.222311099529;6005.309389420273;6063.909041364472;6083.7870674526175;6088.695565221809;6088.969555152373;5742.827715168552;5744.167095771007;5751.654900705971;5832.650040997553;5836.795712150054;5808.82573522795;5972.283326000907;5979;6012.939870601413;6029.974904266373;5776.451237132465;5802.245708057925;5810.680412577349;5814.098814683731;5819.505342045804;5739.483446489836;5762.250907382181;5821.039528477754;5826.563007774349;5829.242198514166;5743.942560574341;5758.856028599319;5769.91345129815;5784.652920824764;5815.127730840408;5737.74180161902;5756.827295181151;5768.740406681625;5814.186013958134;5816.709164541671;5652.3217213934595;5732;5740.741666625096;5742.138679198154;5745.023346031101 17:09:39 INFO - PROCESS | 4760 | |1;ext.html;539.8407469796409;540.3839622829975;544.276112770016;567.0983136812469;587.5974957154347;40057.59942400575;40830.59169408305;40880.38679419811;40890.591094089126;40986.59013409869;44712.10575788482;44790;45057.32414013793;45221.32168017482;45416.77291613537;8821.691240806573;9013.729588112334;9027.503487308195;9041.321900857429;9057.45655260683;8777.780555486132;8859;8860.734177974671;9149.176574108329;9151.176394124528;9185;9241.075892410772;9265.073492650748;9280.396774209688;9282.257419406465;9137.406068605553;9211.723648290528;9214.216791572724;9228.953855230748;9234.353595248336;8977.461352318816;9188.908110918872;9189.770255743593;9231.353805233637;9244.491552964584;43303.56696433058;43612.56387436117;43917;44077.33883991743;44135.55864441379;3186.776925615208;3601.927961440783;3645.0887278180453;3705.6109108543756;3838.174792419615;29618.25954351137;29930.70069299301;30087.097387078422;30337.69662303371;30914.845425772954;4137.098142547719;4187.267228235047;4207.705460617758;4212.915741685149;4219.78901054946;249438;253229.7338513314;253273.4017979445;253762;254553;61574.076388854206;62522;62582;62703.68648156821;62846.685766570874;75660.62169689227;75720;75733;76105;76367.61816190995;15078.698426031637;15191.696166076837;15343;15609.063456192438;15615.141167235912;12025.158238923366;12066.155369124253;12126.514939402501;12136.817947730791;12146;22204.88897555502;22623.434414139778;22713.205037823598;22790.772092279196;23298.767012329998;8570.271526920156;8810.823783524294;8824.911750882537;8885.511296878605;8945.686900958435;963.7831487915163;1107.9889201108047;1118.0440723181725;1127.1546340244815;1133.4924550348017;29745;30486.390272194432;30536.083917482512;30676;30715.69284307173;1124.1400328748514;1148.7587606602708;1150.3558007515817;1152.7118220444888;1217.5555922088374;13971.58085257444;14040.666136716996;14159.079659822079;14311.212883291311;14463.059901106604;360507;536886;540145;545540;546089;55237.44762552404;55919.440805591425;56135.71932140313;56201;56275;1489.41912654065;1503.586513708739;1524.4740564505228;1534.5166272624087;1541.2756004677783;29411.558826618046;29964.400711986073;30057.549136763402;30386.544201836547;30613;51565;51800.481995179565;52017;52363;52529.47470525246;321594;322789.3860530682;323717;324043;324588;35719.28561428809;35988.4601730969;36039;47699.761501192275;47707.76146119247;44129.33805992977;45265.32102018406;48369.82335794968;48935;48998.265026023924;40576.39135412912;41174.38238426366;41273;41361;42154.36768448415;39807.40288895611;40282;40710.79644601758;41288;41737.37393939154;40325;40340.394894076024;40462.797686011385;42680.57319426766;42965.570344297405;32249.87125450598;32619;32701.836490817393;33011.66988330086;33247.66752332446;27123.59314610243;28161.859190703915;28308.493445861477;28413.857930710215;28475.572866407434 17:09:39 INFO - PROCESS | 4760 | |2;jquery.html;381.4621383848772;384.09545520299685;387.43821458884617;392.87428023032606;393.5474204664635;17446;19626.705599415985;19920.50198745032;20245.59508809823;20358.491037724063;17961.01214433209;18380.080995950215;18459.169337379815;18616.34842780503;18652.440426787183;5672;5867.970660146715;5878.823635290927;5901.940980590203;5903.527717782567;5113.488651134894;5301.045811753883;5330.227117068042;5342.786288548454;5355.651882627636;5169.741512924357;5303.840884773463;5305.283786688786;5543.25166102575;5614.326280846304;5602.13166959122;5606.971965140168;5618.971905140448;5625.38120806711;5632.098864181732;5356.839294821161;5403.162509810985;5445.700486473243;5466.753996070186;5490.066688662937;13605.523806666819;13723.794143087762;13818.585442436743;13835.169889806542;16946.3221471141;2245.7754224577575;2253.853499522526;2299.7585253548305;2360.45709486819;2437.1591800828865;9693.321467497279;9999.450030248334;10202.846957295647;11446.255993360404;13569.796453053212;1900.1544312780818;1902.0204594633774;1907.7138429235727;1953.3846838245906;1996.371143089922;69133.99999999949;69691.30308696949;69778.65110674415;71603;71762.99999999948;10318.793624127626;10591.788164236672;10614.097801686943;10733.248672592843;10867.782644347228;13929.651758706113;13967.720645587031;14008.579742607739;14118.294085295694;14139.151650900978;7625.809354766176;7759.961200193963;7814.53112813233;7879.369650427952;7901.881471777928;7664.6934122635585;7685.423593230418;7724.884126738103;7733.342665873463;7805;4067.0645751477327;4319.97840010798;4528.343390208402;4537.274036154199;4604.37840891482;1813.184067169779;1827.762390889176;1842.8617853661028;1867.9719804202948;1907.3515004898402;980.3039841712464;1042.5777560088177;1060.7030031591166;1061.989380106189;1079.5426174664296;16059.197040147947;16331.346746130259;17293.8566689317;17904.373346933055;18131.818681813278;1027.3476342522404;1033.8190816607064;1033.859909986336;1063.7287491689724;1074.8495210670512;9915.305928585074;10120.493975301353;10163.695089147337;10239.334443261165;10318.43248621333;453439;455037;459549;460114;471469;75813;77247;77427.90288388402;78237;78452;1050.3907733514543;1050.9474526273655;1062.3360399750156;1066.642674703983;1068.9946550267355;15613.297401617181;15752;15797.289121989308;16013.199340033185;16109.838901610834;34785;35175.64824351826;35692.92921212368;36024.099397515274;36066.8196659015;49826.25260621021;50484.49515504945;50532;50586.747066264434;51182.74408627933;8060.31487323584;8231.971003624547;8233.094359620556;8236.464629799284;8374.581270936307;7011.789646310619;9835.557399917165;10942.343459392461;11917.62947261076;12027.939860300643;10253.179745620482;10330.225233107396;10363.84454233172;10454.895451045697;10611.151107911503;10607.575696972342;10745.731356716145;10965.451727413756;11018.889811101786;11422;10688.305260158066;10802.351858888493;11007.06439952613;11048.447577620926;11087.722806929569;7600.087989441303;7877.291043806085;7931.048274206902;7943.4042446815565;8086.5148091114725;9948;10485.633002844865;10583;10602.681919542427;10635.574577017142 17:09:39 INFO - PROCESS | 4760 | |3;mootools.html;1612.4759453177717;1643.211258595874;1871.996963249323;1936.5836345185783;1977.8318842898361;7669.654865531051;8167.632456539455;8307.87538186927;8449.746507604774;8458.365622578316;8570.485770853753;8685.609147588359;8745.91254087459;8766.736997890073;8771.47371157731;2477.492114116611;2496.3010357100043;2511.547921374152;2514.35883849619;2516.7231604523486;2394.6886904702365;2448.2288079255068;2470.530599186158;2472.61674440462;2482.404222986488;2429.4533729910804;2442.413820683032;2539.9111031113916;2541.0471073347494;2552.731963143871;2425.2118061629953;2435.1720415058876;2439.377958620549;2524.684414448194;2531.4304281536693;2402.1712509184304;2424.3454267347715;2429.259075981825;2430.331658793828;2434.1115492844983;8457.365697572644;8494.87257691129;8619.1811777881;8623.223909848144;8671.6531338747;5178.637495375326;5357.116075847481;5364.597655175878;5364.91952620711;5372.865678358034;3393.5927688677516;3398.49022646605;3418.282160746246;3513.982430087833;3578.1054736315923;1094.5457635081511;1099;1100.3397961223282;1101.5924108079982;1109.024058828234;12075.09436792244;12145.757084858342;12160.209586376857;12212.32832194229;12227.633171004883;4533.954660453419;4553.886152846206;4638.2115040443205;4664.743439110882;4670.9766451167525;10209.489525523693;10281.434521101412;10318.122959548373;10332.793344133075;10335;5192.948070519322;5226.059309324358;5234.659747116425;5244.265802787613;5247.790088396498;4274.252005898955;4681.9297710534365;4699.295105734099;4739.644526660514;4793.544613261734;4030.6372426481757;4047.372657238133;4092.693048021351;4106.178764247163;4153.252414565347;1274.5539061328645;1305.7845455499926;1311.1674086954852;1315.894728421724;1323.9801402978962;1182.6392950150287;1398.5664444022386;1434.0248630930857;1457.5481600703815;1459.5913144319395;8080.43436959419;8244.29923456501;8251.216134467217;8285.295749861329;8303.626336814857;1106.9280496767685;1166.0962753865651;1201.3512703140382;1257.2456526084277;1257.654145110102;6294.464970477469;6351.841203969845;6379.936200638027;6423.875821731178;6424.196975378078;10080.395176289447;10381.584736610452;10493.475326233658;10494.895051049545;10519.368837869752;9957.701268961942;10153.94923025395;10195.898041019494;10231.744206394751;10488;8151.633176507072;8281.710140145065;8292.668293268202;8308.376871734645;8362.414630975773;7836.882446763417;7914.406419518444;7993.520388776692;8011.799705007422;8059.0732065810835;8986.820263594822;9152.771180720269;9168.312376571917;9231.907680923105;9297.628094876129;9269.907300927174;9327.113924177193;9472.857907131536;9556.139947404767;9609.9039009609;6691.130153080068;7159.105111861018;7163.06880105583;7299.014633024473;7369.4841361106355;7975.680972761256;7995.2804247618;8008.439409241297;8028.4781489203015;8033.397495188001;7193.748218812317;7346.816329591803;7380.335769780745;7403.222661620668;7543.170251272246;7126.180489243803;7158.606276654834;7203.387712044535;7236.131664200119;7418.629068546659;7548.773536793905;7552.358049565849;7577.696892124253;7580.749176385834;7609.315161635479;6784.864302714017;6799.2520822708475;6808.319168083152;6823.454123669995;6844.623545704835;7061.187963384276;7094.148702155774;7095;7106.6446677666945;7144.607046612487 17:09:39 INFO - PROCESS | 4760 | |4;prototype.html;332.51120852347043;336.3625928864801;347.33312040881503;348.76109864742654;354.0652676932896;6407.48740100792;6455.967720161392;6530.085787989679;6532.967335163324;6535.444487218592;6384.648844313561;6415.775447859314;6417.967910160454;6419.518536109798;6424.743010279583;4708.364370809948;4837.540433658797;4849.878753031185;4851.733154676492;4856.0773453043985;4819.7590120494015;4822.228443449048;4825.348577941985;4851.029794041188;4852.611791056707;4730.574248317651;4796.90406191876;4797.376341075656;4800.90398192036;4805.8558243252755;4792.90414191716;4800.927986080212;4804.25534042224;4817.686850354733;4824.614030877521;4114.0948991221885;4166.58334166584;4168.145530166309;4169.812358443877;4175.665946724254;5999.310079340888;6087.878242435127;6131.294901086388;6153.446189842935;6159.38406159385;5555.555555555587;5588.133839254881;5600.859978500529;5601.243832082658;5606.299212598426;6696.866062678768;6714.563553369016;6771.796846094625;6773.322667733237;6773.661316934183;4584.106099310636;4586.380838586815;4593.173228818811;4593.63250939924;4595;7062.717491300393;7070.787876363717;7101.928980710179;7116.359527642485;7139.964300178466;4550.158220729176;4729.976350118227;4734.053189362141;4736.976315118472;4741.2651039089;4763.7141771493125;4775.140474714515;4778.641601879804;4782.880427989258;4791.616670666338;5519.764495379378;5558.305211848519;5569.888602227933;5574.888502229933;5576.832695019156;6750.797476075725;6780.525363224527;6807.421369183675;6808.659567021629;6810.455163586901;1670.2149989504912;1687.6118492746737;1693.1957320272772;1697.2362436903443;1699.065513967313;1085.5115198160859;1099.3239157917824;1108.539955918285;1120.6581992492368;1126.2510430563748;6557.082008518812;6573.276939536647;6588.374104460068;6600.372964568358;6602.40578347951;7064.682089305994;7064.682089305994;7065.328793764585;7068.5758854468895;7085.43316534676;6418.454431373292;6569.507286953498;6636.502262330345;6672.833179170462;6676.499262555328;3845.1732877431486;3846.9038274043373;3857.8263978121054;3878.204967981613;3886.0867696091395;7404.851902962018;7416.44376671741;7419.406447484188;7419.59192244421;7423.554586724814;7271.927280727125;7306.7077316906725;7351.558906465522;7351.77944661661;7368.226336234726;7148.678309475982;7295.452841037049;7317.12194536659;7320.048393708784;7396.038514993016;7097.680604372919;7123.821904452223;7132.9314498794765;7166.390856777232;7266.527675701062;6999.12510936133;7039.049728286821;7043.260457652078;7054.118235220598;7084.610346430995;7379;7404.6667899945705;7405.5926924019695;7414.406847452083;7419.96290018568;4707.81168753246;4845.612351011981;4901.436334821541;4908.631852610997;4917.188663870565;7068.540544864567;7088.822779430349;7102.325279098477;7104.857902842017;7105.0408194893025;6886.10480637514;6893.965530172518;6898.103246577913;6899.724011039703;6909.170899492093;6843.486738494533;6893.862122757617;6894.482913781386;6900.723971041102;6908.1364829396325;6599.574797830361;6672;6790.354916283143;6790.5925644461495;6802.251752307143;6884.139482564679;6885.862282754217;6895.034695142785;6908.620025898624;6908.861822763617;6698.430633396216;6722.899156512754;6778.661066946732;6804.965975170093;6847.144106986627 17:09:39 INFO - PROCESS | 4760 | |5;yui.html;770.1412924589083;824.0399934076801;836.1721895323632;842.5618678287291;852.4501696405817;17041.57396065099;17187.828121718765;17233.396831110913;17256.56858578536;17295.39466118686;15937.681246375094;15949.963252388587;15952.76070858938;16051.277692503836;16091.83908160918;783.2246076384367;945.3713280668347;950.1543626172712;958.3195930889042;959.592173326337;956.5599824080931;960.3805545423198;968.602872822143;969.0842154164318;969.6218474794836;1005.5424781724298;1013.9391636501833;1015.5937624950042;1016.9796604067914;1020.1328870460123;1002.7443002034435;1008.712516932678;1009.5810238750946;1012.1902478017594;1012.7215015870621;740.7222291640635;741.3920585120204;743.7136702369572;746.2052913646949;746.5707218349417;15762.290696918666;15789.368425262976;15798.21008949548;15831.762523562156;15865.603359915978;13583.185008899498;13717.725645487035;13740.65648358799;13925.791113133311;13976.930115349358;11658.242214256046;11924.880751192464;11948.522059117626;12556.497740090386;12573.245605263714;3961.649242054267;4022.3162062449455;4036.9596304036877;4074.8777536673947;4084.3669231268905;52894.20658690123;53892.730536347066;54131;54342.45657543414;54385.45614543844;10509;10956.506957186946;11059.612913547988;11348.262362946381;11382.430878456209;19369.90315048416;19387.127579258966;19388.515287117654;19423.805761942484;19467.707984380246;7732.188120247405;7747.341475974493;7850.685972561034;8356.623951922178;8545.444546104483;4770.308305295713;4783.330333753277;4799.9760001199775;4809.182438985381;4957.3059771632;3309;3317.834108294624;3320.767546271738;3325.467925131967;3365.5456513370873;623.1618473153601;633.6039975015615;644.8678021005683;649;652.1391762873056;631.9715612797435;707.2114592229627;725.5719125715748;728.1989811207629;763.3130182835492;9305;9581.425114493153;9662.806743865083;9756.414615123116;9774.071463210983;701.9122609673791;715.989260161098;725.793148952546;734.4381548115696;738.9113306403266;4328.156009578102;4436.556344365537;4477;4479.686421950432;4500.527444618333;61559.38440615537;61957.38042619516;62442;62500.374996250364;63314.366856330846;54529.1820622691;55452.44547554554;55486;55648.44351556433;55836.72081639566;48839;49143.50856491389;49318.50681493211;49366.75316623466;51287.74356128195;9441.339106262496;9486.573104210465;9531.761705957406;9638.855417168888;10121.291509594257;37405.6259437413;37622.43566346452;37991.81004094962;38674.6132538671;39235.2152956945;46350.30474542952;47384.7630761844;47694.28458573193;48180.5181948176;48772;12096.939515302367;12313.692157696129;12369.62891113268;12423.378831058591;12553.686157846127;13020.804687929878;13079.476820927057;13134.60596182116;13162.934185329395;13232.206067635972;11371.374574398156;11654.825177622173;11985.460654270404;11992.820107698566;12581.811272830731;12575;12694.809577856155;12711.682207944505;12930.676733081747;13223.206607603575;12453.875461245272;12613.936930315289;12754.936225318814;13041.608751737464;13215.537456188988;10101.14140298083;10180.847939388834;10182.185425166117;10277.383356998604;10848.67453976382;10887.673369798918;10902.50938707776;11057.281276716987;11074.778504429705;11080.667579972614 17:09:39 INFO - PROCESS | 4760 | __end_tp_report 17:09:39 INFO - PROCESS | 4760 | __start_cc_report 17:09:39 INFO - PROCESS | 4760 | _x_x_mozilla_cycle_collect,324 17:09:39 INFO - PROCESS | 4760 | __end_cc_report 17:09:39 INFO - PROCESS | 4760 | __startTimestamp1458605379688__endTimestamp 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | ------- Summary: start ------- 17:09:39 INFO - PROCESS | 4760 | Number of tests: 6 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#0] dojo.html Cycles:165 Average:5509.59 Median:5743.94 stddev:606.74 (10.6%) stddev-sans-first:582.89 17:09:39 INFO - PROCESS | 4760 | Values: 3281.8 3330.0 3337.8 3375.7 3377.1 5439.0 5469.4 5481.1 5495.7 5500.7 5442.1 5477.5 5499.1 5505.7 5513.6 4989.2 5035.8 5078.6 5090.2 5101.6 5015.6 5104.2 5110.2 5115.5 5122.2 5055.4 5097.7 5106.7 5108.2 5142.0 5111.1 5122.5 5137.4 5152.8 5154.4 4886.3 4889.0 5131.0 5156.7 5162.9 5340.1 5369.1 5381.8 5387.1 5395.7 5880.9 5916.8 5918.6 5925.1 5936.2 5944.3 5950.1 6015.5 6022.0 6057.0 5541.8 5594.2 5601.9 5608.9 5613.6 5917.4 6051.5 6083.0 6103.6 6117.5 5835.6 5849.2 5886.3 5903.1 5912.5 5919.0 5922.4 5926.9 5927.4 5930.7 5786.5 5804.2 5836.5 5854.9 5896.1 5861.4 5903.4 5903.5 5918.0 5948.4 4485.3 4486.2 4488.8 4497.7 4507.6 4026.6 4026.7 4043.4 4066.2 4099.0 5532.3 5538.5 5628.7 5639.7 5647.2 5985.9 6004.6 6006.8 6023.7 6032.4 5528.5 5577.8 5652.4 5703.0 5709.0 5014.3 5071.5 5084.3 5096.0 5107.7 6103.3 6109.4 6119.9 6120.3 6136.8 5864.8 5866.6 5961.6 5979.5 5982.2 6005.3 6063.9 6083.8 6088.7 6089.0 5742.8 5744.2 5751.7 5832.7 5836.8 5808.8 5972.3 5979.0 6012.9 6030.0 5776.5 5802.2 5810.7 5814.1 5819.5 5739.5 5762.3 5821.0 5826.6 5829.2 5743.9 5758.9 5769.9 5784.7 5815.1 5737.7 5756.8 5768.7 5814.2 5816.7 5652.3 5732.0 5740.7 5742.1 5745.0 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#1] ext.html Cycles:180 Average:54211.50 Median:41223.69 stddev:100305.02 (243.3%) stddev-sans-first:100505.45 17:09:39 INFO - PROCESS | 4760 | Values: 539.8 540.4 544.3 567.1 587.6 40057.6 40830.6 40880.4 40890.6 40986.6 44712.1 44790.0 45057.3 45221.3 45416.8 8821.7 9013.7 9027.5 9041.3 9057.5 8777.8 8859.0 8860.7 9149.2 9151.2 9185.0 9241.1 9265.1 9280.4 9282.3 9137.4 9211.7 9214.2 9229.0 9234.4 8977.5 9188.9 9189.8 9231.4 9244.5 43303.6 43612.6 43917.0 44077.3 44135.6 3186.8 3601.9 3645.1 3705.6 3838.2 29618.3 29930.7 30087.1 30337.7 30914.8 4137.1 4187.3 4207.7 4212.9 4219.8 249438.0 253229.7 253273.4 253762.0 254553.0 61574.1 62522.0 62582.0 62703.7 62846.7 75660.6 75720.0 75733.0 76105.0 76367.6 15078.7 15191.7 15343.0 15609.1 15615.1 12025.2 12066.2 12126.5 12136.8 12146.0 22204.9 22623.4 22713.2 22790.8 23298.8 8570.3 8810.8 8824.9 8885.5 8945.7 963.8 1108.0 1118.0 1127.2 1133.5 29745.0 30486.4 30536.1 30676.0 30715.7 1124.1 1148.8 1150.4 1152.7 1217.6 13971.6 14040.7 14159.1 14311.2 14463.1 360507.0 536886.0 540145.0 545540.0 546089.0 55237.4 55919.4 56135.7 56201.0 56275.0 1489.4 1503.6 1524.5 1534.5 1541.3 29411.6 29964.4 30057.5 30386.5 30613.0 51565.0 51800.5 52017.0 52363.0 52529.5 321594.0 322789.4 323717.0 324043.0 324588.0 35719.3 35988.5 36039.0 47699.8 47707.8 44129.3 45265.3 48369.8 48935.0 48998.3 40576.4 41174.4 41273.0 41361.0 42154.4 39807.4 40282.0 40710.8 41288.0 41737.4 40325.0 40340.4 40462.8 42680.6 42965.6 32249.9 32619.0 32701.8 33011.7 33247.7 27123.6 28161.9 28308.5 28413.9 28475.6 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#2] jquery.html Cycles:180 Average:26424.23 Median:2330.11 stddev:75527.66 (3241.4%) stddev-sans-first:75714.22 17:09:39 INFO - PROCESS | 4760 | Values: 381.5 384.1 387.4 392.9 393.5 17446.0 19626.7 19920.5 20245.6 20358.5 17961.0 18380.1 18459.2 18616.3 18652.4 5672.0 5868.0 5878.8 5901.9 5903.5 5113.5 5301.0 5330.2 5342.8 5355.7 5169.7 5303.8 5305.3 5543.3 5614.3 5602.1 5607.0 5619.0 5625.4 5632.1 5356.8 5403.2 5445.7 5466.8 5490.1 13605.5 13723.8 13818.6 13835.2 16946.3 2245.8 2253.9 2299.8 2360.5 2437.2 9693.3 9999.5 10202.8 11446.3 13569.8 1900.2 1902.0 1907.7 1953.4 1996.4 69134.0 69691.3 69778.7 71603.0 71763.0 10318.8 10591.8 10614.1 10733.2 10867.8 13929.7 13967.7 14008.6 14118.3 14139.2 7625.8 7760.0 7814.5 7879.4 7901.9 7664.7 7685.4 7724.9 7733.3 7805.0 4067.1 4320.0 4528.3 4537.3 4604.4 1813.2 1827.8 1842.9 1868.0 1907.4 980.3 1042.6 1060.7 1062.0 1079.5 16059.2 16331.3 17293.9 17904.4 18131.8 1027.3 1033.8 1033.9 1063.7 1074.8 9915.3 10120.5 10163.7 10239.3 10318.4 453439.0 455037.0 459549.0 460114.0 471469.0 75813.0 77247.0 77427.9 78237.0 78452.0 1050.4 1050.9 1062.3 1066.6 1069.0 15613.3 15752.0 15797.3 16013.2 16109.8 34785.0 35175.6 35692.9 36024.1 36066.8 49826.3 50484.5 50532.0 50586.7 51182.7 8060.3 8232.0 8233.1 8236.5 8374.6 7011.8 9835.6 10942.3 11917.6 12027.9 10253.2 10330.2 10363.8 10454.9 10611.2 10607.6 10745.7 10965.5 11018.9 11422.0 10688.3 10802.4 11007.1 11048.4 11087.7 7600.1 7877.3 7931.0 7943.4 8086.5 9948.0 10485.6 10583.0 10602.7 10635.6 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#3] mootools.html Cycles:180 Average:5993.21 Median:5209.50 stddev:3113.29 (59.8%) stddev-sans-first:3104.61 17:09:39 INFO - PROCESS | 4760 | Values: 1612.5 1643.2 1872.0 1936.6 1977.8 7669.7 8167.6 8307.9 8449.7 8458.4 8570.5 8685.6 8745.9 8766.7 8771.5 2477.5 2496.3 2511.5 2514.4 2516.7 2394.7 2448.2 2470.5 2472.6 2482.4 2429.5 2442.4 2539.9 2541.0 2552.7 2425.2 2435.2 2439.4 2524.7 2531.4 2402.2 2424.3 2429.3 2430.3 2434.1 8457.4 8494.9 8619.2 8623.2 8671.7 5178.6 5357.1 5364.6 5364.9 5372.9 3393.6 3398.5 3418.3 3514.0 3578.1 1094.5 1099.0 1100.3 1101.6 1109.0 12075.1 12145.8 12160.2 12212.3 12227.6 4534.0 4553.9 4638.2 4664.7 4671.0 10209.5 10281.4 10318.1 10332.8 10335.0 5192.9 5226.1 5234.7 5244.3 5247.8 4274.3 4681.9 4699.3 4739.6 4793.5 4030.6 4047.4 4092.7 4106.2 4153.3 1274.6 1305.8 1311.2 1315.9 1324.0 1182.6 1398.6 1434.0 1457.5 1459.6 8080.4 8244.3 8251.2 8285.3 8303.6 1106.9 1166.1 1201.4 1257.2 1257.7 6294.5 6351.8 6379.9 6423.9 6424.2 10080.4 10381.6 10493.5 10494.9 10519.4 9957.7 10153.9 10195.9 10231.7 10488.0 8151.6 8281.7 8292.7 8308.4 8362.4 7836.9 7914.4 7993.5 8011.8 8059.1 8986.8 9152.8 9168.3 9231.9 9297.6 9269.9 9327.1 9472.9 9556.1 9609.9 6691.1 7159.1 7163.1 7299.0 7369.5 7975.7 7995.3 8008.4 8028.5 8033.4 7193.7 7346.8 7380.3 7403.2 7543.2 7126.2 7158.6 7203.4 7236.1 7418.6 7548.8 7552.4 7577.7 7580.7 7609.3 6784.9 6799.3 6808.3 6823.5 6844.6 7061.2 7094.1 7095.0 7106.6 7144.6 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#4] prototype.html Cycles:180 Average:5703.00 Median:6546.26 stddev:1761.35 (26.9%) stddev-sans-first:1719.55 17:09:39 INFO - PROCESS | 4760 | Values: 332.5 336.4 347.3 348.8 354.1 6407.5 6456.0 6530.1 6533.0 6535.4 6384.6 6415.8 6418.0 6419.5 6424.7 4708.4 4837.5 4849.9 4851.7 4856.1 4819.8 4822.2 4825.3 4851.0 4852.6 4730.6 4796.9 4797.4 4800.9 4805.9 4792.9 4800.9 4804.3 4817.7 4824.6 4114.1 4166.6 4168.1 4169.8 4175.7 5999.3 6087.9 6131.3 6153.4 6159.4 5555.6 5588.1 5600.9 5601.2 5606.3 6696.9 6714.6 6771.8 6773.3 6773.7 4584.1 4586.4 4593.2 4593.6 4595.0 7062.7 7070.8 7101.9 7116.4 7140.0 4550.2 4730.0 4734.1 4737.0 4741.3 4763.7 4775.1 4778.6 4782.9 4791.6 5519.8 5558.3 5569.9 5574.9 5576.8 6750.8 6780.5 6807.4 6808.7 6810.5 1670.2 1687.6 1693.2 1697.2 1699.1 1085.5 1099.3 1108.5 1120.7 1126.3 6557.1 6573.3 6588.4 6600.4 6602.4 7064.7 7064.7 7065.3 7068.6 7085.4 6418.5 6569.5 6636.5 6672.8 6676.5 3845.2 3846.9 3857.8 3878.2 3886.1 7404.9 7416.4 7419.4 7419.6 7423.6 7271.9 7306.7 7351.6 7351.8 7368.2 7148.7 7295.5 7317.1 7320.0 7396.0 7097.7 7123.8 7132.9 7166.4 7266.5 6999.1 7039.0 7043.3 7054.1 7084.6 7379.0 7404.7 7405.6 7414.4 7420.0 4707.8 4845.6 4901.4 4908.6 4917.2 7068.5 7088.8 7102.3 7104.9 7105.0 6886.1 6894.0 6898.1 6899.7 6909.2 6843.5 6893.9 6894.5 6900.7 6908.1 6599.6 6672.0 6790.4 6790.6 6802.3 6884.1 6885.9 6895.0 6908.6 6908.9 6698.4 6722.9 6778.7 6805.0 6847.1 17:09:39 INFO - PROCESS | 4760 | 17:09:39 INFO - PROCESS | 4760 | [#5] yui.html Cycles:180 Average:15232.32 Median:21598.43 stddev:17283.33 (80.0%) stddev-sans-first:17297.69 17:09:39 INFO - PROCESS | 4760 | Values: 770.1 824.0 836.2 842.6 852.5 17041.6 17187.8 17233.4 17256.6 17295.4 15937.7 15950.0 15952.8 16051.3 16091.8 783.2 945.4 950.2 958.3 959.6 956.6 960.4 968.6 969.1 969.6 1005.5 1013.9 1015.6 1017.0 1020.1 1002.7 1008.7 1009.6 1012.2 1012.7 740.7 741.4 743.7 746.2 746.6 15762.3 15789.4 15798.2 15831.8 15865.6 13583.2 13717.7 13740.7 13925.8 13976.9 11658.2 11924.9 11948.5 12556.5 12573.2 3961.6 4022.3 4037.0 4074.9 4084.4 52894.2 53892.7 54131.0 54342.5 54385.5 10509.0 10956.5 11059.6 11348.3 11382.4 19369.9 19387.1 19388.5 19423.8 19467.7 7732.2 7747.3 7850.7 8356.6 8545.4 4770.3 4783.3 4800.0 4809.2 4957.3 3309.0 3317.8 3320.8 3325.5 3365.5 623.2 633.6 644.9 649.0 652.1 632.0 707.2 725.6 728.2 763.3 9305.0 9581.4 9662.8 9756.4 9774.1 701.9 716.0 725.8 734.4 738.9 4328.2 4436.6 4477.0 4479.7 4500.5 61559.4 61957.4 62442.0 62500.4 63314.4 54529.2 55452.4 55486.0 55648.4 55836.7 48839.0 49143.5 49318.5 49366.8 51287.7 9441.3 9486.6 9531.8 9638.9 10121.3 37405.6 37622.4 37991.8 38674.6 39235.2 46350.3 47384.8 47694.3 48180.5 48772.0 12096.9 12313.7 12369.6 12423.4 12553.7 13020.8 13079.5 13134.6 13162.9 13232.2 11371.4 11654.8 11985.5 11992.8 12581.8 12575.0 12694.8 12711.7 12930.7 13223.2 12453.9 12613.9 12754.9 13041.6 13215.5 10101.1 10180.8 10182.2 10277.4 10848.7 10887.7 10902.5 11057.3 11074.8 11080.7 17:09:39 INFO - PROCESS | 4760 | -------- Summary: end -------- 17:09:39 INFO - PROCESS | 4760 | 17:09:40 INFO - TEST-INFO | 4760: exit 0 17:09:40 INFO - TEST-OK | dromaeo_css | took 1109560ms 17:09:40 INFO - TEST-START | kraken 17:09:40 INFO - operating with platform_type : linux_ 17:09:40 INFO - Initialising browser for kraken test... 17:09:40 INFO - TEST-INFO | started process 5006 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp79otNQ/profile http://localhost:33211/getInfo.html) 17:09:43 INFO - PROCESS | 5006 | 17:09:43 INFO - PROCESS | 5006 | (process:5082): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:44 INFO - PROCESS | 5006 | __metrics Screen width/height:1600/1200 17:09:44 INFO - PROCESS | 5006 | colorDepth:24 17:09:44 INFO - PROCESS | 5006 | Browser inner width/height: 1024/697 17:09:44 INFO - PROCESS | 5006 | __metrics 17:09:45 ERROR - PROCESS | 5006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:09:46 INFO - TEST-INFO | 5006: exit 0 17:09:46 INFO - Browser initialized. 17:09:46 INFO - Running cycle 1/1 for kraken test... 17:09:46 INFO - TEST-INFO | started process 5133 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp79otNQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:47 INFO - PROCESS | 5133 | 17:09:47 INFO - PROCESS | 5133 | (process:5200): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:57 INFO - PROCESS | 5133 | RSS: Main: 154243072 17:09:57 INFO - PROCESS | 5133 | 17:10:00 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:01 INFO - PROCESS | 5133 | RSS: Main: 159350784 17:10:01 INFO - PROCESS | 5133 | 17:10:03 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-dft) 17:10:04 INFO - PROCESS | 5133 | RSS: Main: 158666752 17:10:04 INFO - PROCESS | 5133 | 17:10:07 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-fft) 17:10:07 INFO - PROCESS | 5133 | RSS: Main: 158502912 17:10:07 INFO - PROCESS | 5133 | 17:10:09 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33211/tests/kraken/driver.html?testName=audio-oscillator) 17:10:10 INFO - PROCESS | 5133 | RSS: Main: 158248960 17:10:10 INFO - PROCESS | 5133 | 17:10:12 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:13 INFO - PROCESS | 5133 | RSS: Main: 158371840 17:10:13 INFO - PROCESS | 5133 | 17:10:16 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:16 INFO - PROCESS | 5133 | RSS: Main: 158937088 17:10:16 INFO - PROCESS | 5133 | 17:10:20 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33211/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:20 INFO - PROCESS | 5133 | RSS: Main: 159166464 17:10:20 INFO - PROCESS | 5133 | 17:10:23 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33211/tests/kraken/driver.html?testName=json-parse-financial) 17:10:24 INFO - PROCESS | 5133 | RSS: Main: 158920704 17:10:24 INFO - PROCESS | 5133 | 17:10:25 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:26 INFO - PROCESS | 5133 | RSS: Main: 159035392 17:10:26 INFO - PROCESS | 5133 | 17:10:28 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:28 INFO - PROCESS | 5133 | RSS: Main: 158334976 17:10:28 INFO - PROCESS | 5133 | 17:10:30 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:31 INFO - PROCESS | 5133 | RSS: Main: 159313920 17:10:31 INFO - PROCESS | 5133 | 17:10:33 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:34 INFO - PROCESS | 5133 | RSS: Main: 159174656 17:10:34 INFO - PROCESS | 5133 | 17:10:36 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:37 INFO - PROCESS | 5133 | RSS: Main: 158773248 17:10:37 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | Cycle 1(1): loaded http://localhost:33211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33211/tests/kraken/driver.html?testName=ai-astar) 17:10:39 INFO - PROCESS | 5133 | RSS: Main: 161071104 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | __start_tp_report 17:10:39 INFO - PROCESS | 5133 | _x_x_mozilla_page_load 17:10:39 INFO - PROCESS | 5133 | _x_x_mozilla_page_load_details 17:10:39 INFO - PROCESS | 5133 | |i|pagename|runs| 17:10:39 INFO - PROCESS | 5133 | |0;ai-astar;110;105;109;109;112;121;110;111;110;111 17:10:39 INFO - PROCESS | 5133 | |1;audio-beat-detection;151;130;157;172;133;172;150;134;176;126 17:10:39 INFO - PROCESS | 5133 | |2;audio-dft;164;161;163;163;163;164;161;164;163;163 17:10:39 INFO - PROCESS | 5133 | |3;audio-fft;71;77;73;155;75;75;75;72;160;75 17:10:39 INFO - PROCESS | 5133 | |4;audio-oscillator;93;92;139;92;92;92;140;93;92;138 17:10:39 INFO - PROCESS | 5133 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;117;117 17:10:39 INFO - PROCESS | 5133 | |6;imaging-darkroom;147;146;148;146;148;146;146;146;147;146 17:10:39 INFO - PROCESS | 5133 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;95 17:10:39 INFO - PROCESS | 5133 | |8;json-parse-financial;57;59;56;56;56;57;55;63;63;54 17:10:39 INFO - PROCESS | 5133 | |9;json-stringify-tinderbox;64;65;65;66;65;67;64;65;65;65 17:10:39 INFO - PROCESS | 5133 | |10;stanford-crypto-aes;78;79;80;86;80;80;79;80;78;78 17:10:39 INFO - PROCESS | 5133 | |11;stanford-crypto-ccm;112;112;115;112;112;118;117;112;115;110 17:10:39 INFO - PROCESS | 5133 | |12;stanford-crypto-pbkdf2;136;136;149;145;133;133;147;143;151;140 17:10:39 INFO - PROCESS | 5133 | |13;stanford-crypto-sha256-iterative;68;65;67;66;65;67;74;69;65;68 17:10:39 INFO - PROCESS | 5133 | __end_tp_report 17:10:39 INFO - PROCESS | 5133 | __start_cc_report 17:10:39 INFO - PROCESS | 5133 | _x_x_mozilla_cycle_collect,829 17:10:39 INFO - PROCESS | 5133 | __end_cc_report 17:10:39 INFO - PROCESS | 5133 | __startTimestamp1458605439484__endTimestamp 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | ------- Summary: start ------- 17:10:39 INFO - PROCESS | 5133 | Number of tests: 14 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:4.05 (3.7%) stddev-sans-first:4.28 17:10:39 INFO - PROCESS | 5133 | Values: 110.0 105.0 109.0 109.0 112.0 121.0 110.0 111.0 110.0 111.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:154.00 stddev:18.90 (12.3%) stddev-sans-first:20.04 17:10:39 INFO - PROCESS | 5133 | Values: 151.0 130.0 157.0 172.0 133.0 172.0 150.0 134.0 176.0 126.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 17:10:39 INFO - PROCESS | 5133 | Values: 164.0 161.0 163.0 163.0 163.0 164.0 161.0 164.0 163.0 163.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#3] audio-fft Cycles:10 Average:90.80 Median:75.00 stddev:35.22 (47.0%) stddev-sans-first:36.62 17:10:39 INFO - PROCESS | 5133 | Values: 71.0 77.0 73.0 155.0 75.0 75.0 75.0 72.0 160.0 75.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:92.00 stddev:22.57 (24.5%) stddev-sans-first:23.42 17:10:39 INFO - PROCESS | 5133 | Values: 93.0 92.0 139.0 92.0 92.0 92.0 140.0 93.0 92.0 138.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:10:39 INFO - PROCESS | 5133 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 17:10:39 INFO - PROCESS | 5133 | Values: 147.0 146.0 148.0 146.0 148.0 146.0 146.0 146.0 147.0 146.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:10:39 INFO - PROCESS | 5133 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.13 (5.5%) stddev-sans-first:3.32 17:10:39 INFO - PROCESS | 5133 | Values: 57.0 59.0 56.0 56.0 56.0 57.0 55.0 63.0 63.0 54.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 17:10:39 INFO - PROCESS | 5133 | Values: 64.0 65.0 65.0 66.0 65.0 67.0 64.0 65.0 65.0 65.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:2.35 (2.9%) stddev-sans-first:2.40 17:10:39 INFO - PROCESS | 5133 | Values: 78.0 79.0 80.0 86.0 80.0 80.0 79.0 80.0 78.0 78.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#11] stanford-crypto-ccm Cycles:10 Average:113.50 Median:113.50 stddev:2.59 (2.3%) stddev-sans-first:2.69 17:10:39 INFO - PROCESS | 5133 | Values: 112.0 112.0 115.0 112.0 112.0 118.0 117.0 112.0 115.0 110.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:144.00 stddev:6.65 (4.6%) stddev-sans-first:6.77 17:10:39 INFO - PROCESS | 5133 | Values: 136.0 136.0 149.0 145.0 133.0 133.0 147.0 143.0 151.0 140.0 17:10:39 INFO - PROCESS | 5133 | 17:10:39 INFO - PROCESS | 5133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.72 (4.0%) stddev-sans-first:2.87 17:10:39 INFO - PROCESS | 5133 | Values: 68.0 65.0 67.0 66.0 65.0 67.0 74.0 69.0 65.0 68.0 17:10:39 INFO - PROCESS | 5133 | -------- Summary: end -------- 17:10:39 INFO - PROCESS | 5133 | 17:10:40 INFO - TEST-INFO | 5133: exit 0 17:10:40 INFO - TEST-OK | kraken | took 60043ms 17:10:40 INFO - SUITE-END | took 1169s 17:10:40 INFO - Completed test suite (00:19:29) 17:10:40 INFO - javascript benchmark 17:10:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3281.8194999275042, 3329.9833500832524, 3337.7830441021338, 3375.662433756623, 3377.071305391017, 5439.0, 5469.371022332433, 5481.12302031675, 5495.670259784406, 5500.724963751816, 5442.102053161234, 5477.4796394342475, 5499.092649712793, 5505.697186654733, 5513.58648101393, 4989.176785830334, 5035.798568057273, 5078.5937125029905, 5090.185570308751, 5101.591872650198, 5015.5736762375245, 5104.157813960692, 5110.182370820651, 5115.53960143587, 5122.206058061007, 5055.39335279767, 5097.668651537657, 5106.744662766865, 5108.157154069574, 5141.974290128544, 5111.13110771168, 5122.487751224885, 5137.434882162959, 5152.768125434327, 5154.4072431670465, 4886.3403440535785, 4888.951110488921, 5131.0, 5156.664816786897, 5162.870928226786, 5340.092184328673, 5369.140937450028, 5381.784728610851, 5387.0841956867425, 5395.676259424408, 5880.912031274185, 5916.822495325147, 5918.644881307136, 5925.140854576105, 5936.228290322274, 5944.316403613553, 5950.137230101611, 6015.518758499309, 6021.969890150565, 6056.96971515144, 5541.836214394982, 5594.216809646653, 5601.915971260434, 5608.887822243573, 5613.607047506676, 5917.437843404869, 6051.4553690168095, 6082.9695851520455, 6103.6032657877095, 6117.541184411098, 5835.56233282497, 5849.151872978395, 5886.264216972879, 5903.114532820111, 5912.46787789101, 5919.0, 5922.407759224043, 5926.851828704317, 5927.3776253493625, 5930.703464826827, 5786.450287222707, 5804.245448091806, 5836.474717275466, 5854.882902342015, 5896.115582662549, 5861.3552509223955, 5903.380145084704, 5903.498202652737, 5918.0, 5948.405159484104, 4485.349624304457, 4486.170058539181, 4488.842890498817, 4497.685162038626, 4507.5943165115295, 4026.5570787213383, 4026.7382620129597, 4043.433919251307, 4066.186762647423, 4099.036726369301, 5532.336119665585, 5538.529225015838, 5628.746706398222, 5639.661620302795, 5647.237622920853, 5985.9401405986255, 6004.609700369462, 6006.849828754316, 6023.728932198062, 6032.39676032402, 5528.474794894479, 5577.8047768327915, 5652.434756524314, 5703.030484817591, 5709.029464990961, 5014.2979982802435, 5071.4928507149725, 5084.288199652052, 5096.0, 5107.693538387709, 6103.267607887082, 6109.389061093855, 6119.938800612026, 6120.326764055951, 6136.846578835565, 5864.765409383577, 5866.6186697864505, 5961.582689211714, 5979.4618484336615, 5982.222311099529, 6005.309389420273, 6063.909041364472, 6083.7870674526175, 6088.695565221809, 6088.969555152373, 5742.827715168552, 5744.167095771007, 5751.654900705971, 5832.650040997553, 5836.795712150054, 5808.82573522795, 5972.283326000907, 5979.0, 6012.939870601413, 6029.974904266373, 5776.451237132465, 5802.245708057925, 5810.680412577349, 5814.098814683731, 5819.505342045804, 5739.483446489836, 5762.250907382181, 5821.039528477754, 5826.563007774349, 5829.242198514166, 5743.942560574341, 5758.856028599319, 5769.91345129815, 5784.652920824764, 5815.127730840408, 5737.74180161902, 5756.827295181151, 5768.740406681625, 5814.186013958134, 5816.709164541671, 5652.3217213934595, 5732.0, 5740.741666625096, 5742.138679198154, 5745.023346031101], "unit": "score", "name": "dojo.html", "value": 5470.39371083652}, {"lowerIsBetter": false, "replicates": [539.8407469796409, 540.3839622829975, 544.276112770016, 567.0983136812469, 587.5974957154347, 40057.59942400575, 40830.59169408305, 40880.38679419811, 40890.591094089126, 40986.59013409869, 44712.10575788482, 44790.0, 45057.32414013793, 45221.32168017482, 45416.77291613537, 8821.691240806573, 9013.729588112334, 9027.503487308195, 9041.321900857429, 9057.45655260683, 8777.780555486132, 8859.0, 8860.734177974671, 9149.176574108329, 9151.176394124528, 9185.0, 9241.075892410772, 9265.073492650748, 9280.396774209688, 9282.257419406465, 9137.406068605553, 9211.723648290528, 9214.216791572724, 9228.953855230748, 9234.353595248336, 8977.461352318816, 9188.908110918872, 9189.770255743593, 9231.353805233637, 9244.491552964584, 43303.56696433058, 43612.56387436117, 43917.0, 44077.33883991743, 44135.55864441379, 3186.776925615208, 3601.927961440783, 3645.0887278180453, 3705.6109108543756, 3838.174792419615, 29618.25954351137, 29930.70069299301, 30087.097387078422, 30337.69662303371, 30914.845425772954, 4137.098142547719, 4187.267228235047, 4207.705460617758, 4212.915741685149, 4219.78901054946, 249438.0, 253229.7338513314, 253273.4017979445, 253762.0, 254553.0, 61574.076388854206, 62522.0, 62582.0, 62703.68648156821, 62846.685766570874, 75660.62169689227, 75720.0, 75733.0, 76105.0, 76367.61816190995, 15078.698426031637, 15191.696166076837, 15343.0, 15609.063456192438, 15615.141167235912, 12025.158238923366, 12066.155369124253, 12126.514939402501, 12136.817947730791, 12146.0, 22204.88897555502, 22623.434414139778, 22713.205037823598, 22790.772092279196, 23298.767012329998, 8570.271526920156, 8810.823783524294, 8824.911750882537, 8885.511296878605, 8945.686900958435, 963.7831487915163, 1107.9889201108047, 1118.0440723181725, 1127.1546340244815, 1133.4924550348017, 29745.0, 30486.390272194432, 30536.083917482512, 30676.0, 30715.69284307173, 1124.1400328748514, 1148.7587606602708, 1150.3558007515817, 1152.7118220444888, 1217.5555922088374, 13971.58085257444, 14040.666136716996, 14159.079659822079, 14311.212883291311, 14463.059901106604, 360507.0, 536886.0, 540145.0, 545540.0, 546089.0, 55237.44762552404, 55919.440805591425, 56135.71932140313, 56201.0, 56275.0, 1489.41912654065, 1503.586513708739, 1524.4740564505228, 1534.5166272624087, 1541.2756004677783, 29411.558826618046, 29964.400711986073, 30057.549136763402, 30386.544201836547, 30613.0, 51565.0, 51800.481995179565, 52017.0, 52363.0, 52529.47470525246, 321594.0, 322789.3860530682, 323717.0, 324043.0, 324588.0, 35719.28561428809, 35988.4601730969, 36039.0, 47699.761501192275, 47707.76146119247, 44129.33805992977, 45265.32102018406, 48369.82335794968, 48935.0, 48998.265026023924, 40576.39135412912, 41174.38238426366, 41273.0, 41361.0, 42154.36768448415, 39807.40288895611, 40282.0, 40710.79644601758, 41288.0, 41737.37393939154, 40325.0, 40340.394894076024, 40462.797686011385, 42680.57319426766, 42965.570344297405, 32249.87125450598, 32619.0, 32701.836490817393, 33011.66988330086, 33247.66752332446, 27123.59314610243, 28161.859190703915, 28308.493445861477, 28413.857930710215, 28475.572866407434], "unit": "score", "name": "ext.html", "value": 20108.40662162758}, {"lowerIsBetter": false, "replicates": [381.4621383848772, 384.09545520299685, 387.43821458884617, 392.87428023032606, 393.5474204664635, 17446.0, 19626.705599415985, 19920.50198745032, 20245.59508809823, 20358.491037724063, 17961.01214433209, 18380.080995950215, 18459.169337379815, 18616.34842780503, 18652.440426787183, 5672.0, 5867.970660146715, 5878.823635290927, 5901.940980590203, 5903.527717782567, 5113.488651134894, 5301.045811753883, 5330.227117068042, 5342.786288548454, 5355.651882627636, 5169.741512924357, 5303.840884773463, 5305.283786688786, 5543.25166102575, 5614.326280846304, 5602.13166959122, 5606.971965140168, 5618.971905140448, 5625.38120806711, 5632.098864181732, 5356.839294821161, 5403.162509810985, 5445.700486473243, 5466.753996070186, 5490.066688662937, 13605.523806666819, 13723.794143087762, 13818.585442436743, 13835.169889806542, 16946.3221471141, 2245.7754224577575, 2253.853499522526, 2299.7585253548305, 2360.45709486819, 2437.1591800828865, 9693.321467497279, 9999.450030248334, 10202.846957295647, 11446.255993360404, 13569.796453053212, 1900.1544312780818, 1902.0204594633774, 1907.7138429235727, 1953.3846838245906, 1996.371143089922, 69133.99999999949, 69691.30308696949, 69778.65110674415, 71603.0, 71762.99999999948, 10318.793624127626, 10591.788164236672, 10614.097801686943, 10733.248672592843, 10867.782644347228, 13929.651758706113, 13967.720645587031, 14008.579742607739, 14118.294085295694, 14139.151650900978, 7625.809354766176, 7759.961200193963, 7814.53112813233, 7879.369650427952, 7901.881471777928, 7664.6934122635585, 7685.423593230418, 7724.884126738103, 7733.342665873463, 7805.0, 4067.0645751477327, 4319.97840010798, 4528.343390208402, 4537.274036154199, 4604.37840891482, 1813.184067169779, 1827.762390889176, 1842.8617853661028, 1867.9719804202948, 1907.3515004898402, 980.3039841712464, 1042.5777560088177, 1060.7030031591166, 1061.989380106189, 1079.5426174664296, 16059.197040147947, 16331.346746130259, 17293.8566689317, 17904.373346933055, 18131.818681813278, 1027.3476342522404, 1033.8190816607064, 1033.859909986336, 1063.7287491689724, 1074.8495210670512, 9915.305928585074, 10120.493975301353, 10163.695089147337, 10239.334443261165, 10318.43248621333, 453439.0, 455037.0, 459549.0, 460114.0, 471469.0, 75813.0, 77247.0, 77427.90288388402, 78237.0, 78452.0, 1050.3907733514543, 1050.9474526273655, 1062.3360399750156, 1066.642674703983, 1068.9946550267355, 15613.297401617181, 15752.0, 15797.289121989308, 16013.199340033185, 16109.838901610834, 34785.0, 35175.64824351826, 35692.92921212368, 36024.099397515274, 36066.8196659015, 49826.25260621021, 50484.49515504945, 50532.0, 50586.747066264434, 51182.74408627933, 8060.31487323584, 8231.971003624547, 8233.094359620556, 8236.464629799284, 8374.581270936307, 7011.789646310619, 9835.557399917165, 10942.343459392461, 11917.62947261076, 12027.939860300643, 10253.179745620482, 10330.225233107396, 10363.84454233172, 10454.895451045697, 10611.151107911503, 10607.575696972342, 10745.731356716145, 10965.451727413756, 11018.889811101786, 11422.0, 10688.305260158066, 10802.351858888493, 11007.06439952613, 11048.447577620926, 11087.722806929569, 7600.087989441303, 7877.291043806085, 7931.048274206902, 7943.4042446815565, 8086.5148091114725, 9948.0, 10485.633002844865, 10583.0, 10602.681919542427, 10635.574577017142], "unit": "score", "name": "jquery.html", "value": 8614.285560634466}, {"lowerIsBetter": false, "replicates": [1612.4759453177717, 1643.211258595874, 1871.996963249323, 1936.5836345185783, 1977.8318842898361, 7669.654865531051, 8167.632456539455, 8307.87538186927, 8449.746507604774, 8458.365622578316, 8570.485770853753, 8685.609147588359, 8745.91254087459, 8766.736997890073, 8771.47371157731, 2477.492114116611, 2496.3010357100043, 2511.547921374152, 2514.35883849619, 2516.7231604523486, 2394.6886904702365, 2448.2288079255068, 2470.530599186158, 2472.61674440462, 2482.404222986488, 2429.4533729910804, 2442.413820683032, 2539.9111031113916, 2541.0471073347494, 2552.731963143871, 2425.2118061629953, 2435.1720415058876, 2439.377958620549, 2524.684414448194, 2531.4304281536693, 2402.1712509184304, 2424.3454267347715, 2429.259075981825, 2430.331658793828, 2434.1115492844983, 8457.365697572644, 8494.87257691129, 8619.1811777881, 8623.223909848144, 8671.6531338747, 5178.637495375326, 5357.116075847481, 5364.597655175878, 5364.91952620711, 5372.865678358034, 3393.5927688677516, 3398.49022646605, 3418.282160746246, 3513.982430087833, 3578.1054736315923, 1094.5457635081511, 1099.0, 1100.3397961223282, 1101.5924108079982, 1109.024058828234, 12075.09436792244, 12145.757084858342, 12160.209586376857, 12212.32832194229, 12227.633171004883, 4533.954660453419, 4553.886152846206, 4638.2115040443205, 4664.743439110882, 4670.9766451167525, 10209.489525523693, 10281.434521101412, 10318.122959548373, 10332.793344133075, 10335.0, 5192.948070519322, 5226.059309324358, 5234.659747116425, 5244.265802787613, 5247.790088396498, 4274.252005898955, 4681.9297710534365, 4699.295105734099, 4739.644526660514, 4793.544613261734, 4030.6372426481757, 4047.372657238133, 4092.693048021351, 4106.178764247163, 4153.252414565347, 1274.5539061328645, 1305.7845455499926, 1311.1674086954852, 1315.894728421724, 1323.9801402978962, 1182.6392950150287, 1398.5664444022386, 1434.0248630930857, 1457.5481600703815, 1459.5913144319395, 8080.43436959419, 8244.29923456501, 8251.216134467217, 8285.295749861329, 8303.626336814857, 1106.9280496767685, 1166.0962753865651, 1201.3512703140382, 1257.2456526084277, 1257.654145110102, 6294.464970477469, 6351.841203969845, 6379.936200638027, 6423.875821731178, 6424.196975378078, 10080.395176289447, 10381.584736610452, 10493.475326233658, 10494.895051049545, 10519.368837869752, 9957.701268961942, 10153.94923025395, 10195.898041019494, 10231.744206394751, 10488.0, 8151.633176507072, 8281.710140145065, 8292.668293268202, 8308.376871734645, 8362.414630975773, 7836.882446763417, 7914.406419518444, 7993.520388776692, 8011.799705007422, 8059.0732065810835, 8986.820263594822, 9152.771180720269, 9168.312376571917, 9231.907680923105, 9297.628094876129, 9269.907300927174, 9327.113924177193, 9472.857907131536, 9556.139947404767, 9609.9039009609, 6691.130153080068, 7159.105111861018, 7163.06880105583, 7299.014633024473, 7369.4841361106355, 7975.680972761256, 7995.2804247618, 8008.439409241297, 8028.4781489203015, 8033.397495188001, 7193.748218812317, 7346.816329591803, 7380.335769780745, 7403.222661620668, 7543.170251272246, 7126.180489243803, 7158.606276654834, 7203.387712044535, 7236.131664200119, 7418.629068546659, 7548.773536793905, 7552.358049565849, 7577.696892124253, 7580.749176385834, 7609.315161635479, 6784.864302714017, 6799.2520822708475, 6808.319168083152, 6823.454123669995, 6844.623545704835, 7061.187963384276, 7094.148702155774, 7095.0, 7106.6446677666945, 7144.607046612487], "unit": "score", "name": "mootools.html", "value": 4935.83537663902}, {"lowerIsBetter": false, "replicates": [332.51120852347043, 336.3625928864801, 347.33312040881503, 348.76109864742654, 354.0652676932896, 6407.48740100792, 6455.967720161392, 6530.085787989679, 6532.967335163324, 6535.444487218592, 6384.648844313561, 6415.775447859314, 6417.967910160454, 6419.518536109798, 6424.743010279583, 4708.364370809948, 4837.540433658797, 4849.878753031185, 4851.733154676492, 4856.0773453043985, 4819.7590120494015, 4822.228443449048, 4825.348577941985, 4851.029794041188, 4852.611791056707, 4730.574248317651, 4796.90406191876, 4797.376341075656, 4800.90398192036, 4805.8558243252755, 4792.90414191716, 4800.927986080212, 4804.25534042224, 4817.686850354733, 4824.614030877521, 4114.0948991221885, 4166.58334166584, 4168.145530166309, 4169.812358443877, 4175.665946724254, 5999.310079340888, 6087.878242435127, 6131.294901086388, 6153.446189842935, 6159.38406159385, 5555.555555555587, 5588.133839254881, 5600.859978500529, 5601.243832082658, 5606.299212598426, 6696.866062678768, 6714.563553369016, 6771.796846094625, 6773.322667733237, 6773.661316934183, 4584.106099310636, 4586.380838586815, 4593.173228818811, 4593.63250939924, 4595.0, 7062.717491300393, 7070.787876363717, 7101.928980710179, 7116.359527642485, 7139.964300178466, 4550.158220729176, 4729.976350118227, 4734.053189362141, 4736.976315118472, 4741.2651039089, 4763.7141771493125, 4775.140474714515, 4778.641601879804, 4782.880427989258, 4791.616670666338, 5519.764495379378, 5558.305211848519, 5569.888602227933, 5574.888502229933, 5576.832695019156, 6750.797476075725, 6780.525363224527, 6807.421369183675, 6808.659567021629, 6810.455163586901, 1670.2149989504912, 1687.6118492746737, 1693.1957320272772, 1697.2362436903443, 1699.065513967313, 1085.5115198160859, 1099.3239157917824, 1108.539955918285, 1120.6581992492368, 1126.2510430563748, 6557.082008518812, 6573.276939536647, 6588.374104460068, 6600.372964568358, 6602.40578347951, 7064.682089305994, 7064.682089305994, 7065.328793764585, 7068.5758854468895, 7085.43316534676, 6418.454431373292, 6569.507286953498, 6636.502262330345, 6672.833179170462, 6676.499262555328, 3845.1732877431486, 3846.9038274043373, 3857.8263978121054, 3878.204967981613, 3886.0867696091395, 7404.851902962018, 7416.44376671741, 7419.406447484188, 7419.59192244421, 7423.554586724814, 7271.927280727125, 7306.7077316906725, 7351.558906465522, 7351.77944661661, 7368.226336234726, 7148.678309475982, 7295.452841037049, 7317.12194536659, 7320.048393708784, 7396.038514993016, 7097.680604372919, 7123.821904452223, 7132.9314498794765, 7166.390856777232, 7266.527675701062, 6999.12510936133, 7039.049728286821, 7043.260457652078, 7054.118235220598, 7084.610346430995, 7379.0, 7404.6667899945705, 7405.5926924019695, 7414.406847452083, 7419.96290018568, 4707.81168753246, 4845.612351011981, 4901.436334821541, 4908.631852610997, 4917.188663870565, 7068.540544864567, 7088.822779430349, 7102.325279098477, 7104.857902842017, 7105.0408194893025, 6886.10480637514, 6893.965530172518, 6898.103246577913, 6899.724011039703, 6909.170899492093, 6843.486738494533, 6893.862122757617, 6894.482913781386, 6900.723971041102, 6908.1364829396325, 6599.574797830361, 6672.0, 6790.354916283143, 6790.5925644461495, 6802.251752307143, 6884.139482564679, 6885.862282754217, 6895.034695142785, 6908.620025898624, 6908.861822763617, 6698.430633396216, 6722.899156512754, 6778.661066946732, 6804.965975170093, 6847.144106986627], "unit": "score", "name": "prototype.html", "value": 5121.094211282088}, {"lowerIsBetter": false, "replicates": [770.1412924589083, 824.0399934076801, 836.1721895323632, 842.5618678287291, 852.4501696405817, 17041.57396065099, 17187.828121718765, 17233.396831110913, 17256.56858578536, 17295.39466118686, 15937.681246375094, 15949.963252388587, 15952.76070858938, 16051.277692503836, 16091.83908160918, 783.2246076384367, 945.3713280668347, 950.1543626172712, 958.3195930889042, 959.592173326337, 956.5599824080931, 960.3805545423198, 968.602872822143, 969.0842154164318, 969.6218474794836, 1005.5424781724298, 1013.9391636501833, 1015.5937624950042, 1016.9796604067914, 1020.1328870460123, 1002.7443002034435, 1008.712516932678, 1009.5810238750946, 1012.1902478017594, 1012.7215015870621, 740.7222291640635, 741.3920585120204, 743.7136702369572, 746.2052913646949, 746.5707218349417, 15762.290696918666, 15789.368425262976, 15798.21008949548, 15831.762523562156, 15865.603359915978, 13583.185008899498, 13717.725645487035, 13740.65648358799, 13925.791113133311, 13976.930115349358, 11658.242214256046, 11924.880751192464, 11948.522059117626, 12556.497740090386, 12573.245605263714, 3961.649242054267, 4022.3162062449455, 4036.9596304036877, 4074.8777536673947, 4084.3669231268905, 52894.20658690123, 53892.730536347066, 54131.0, 54342.45657543414, 54385.45614543844, 10509.0, 10956.506957186946, 11059.612913547988, 11348.262362946381, 11382.430878456209, 19369.90315048416, 19387.127579258966, 19388.515287117654, 19423.805761942484, 19467.707984380246, 7732.188120247405, 7747.341475974493, 7850.685972561034, 8356.623951922178, 8545.444546104483, 4770.308305295713, 4783.330333753277, 4799.9760001199775, 4809.182438985381, 4957.3059771632, 3309.0, 3317.834108294624, 3320.767546271738, 3325.467925131967, 3365.5456513370873, 623.1618473153601, 633.6039975015615, 644.8678021005683, 649.0, 652.1391762873056, 631.9715612797435, 707.2114592229627, 725.5719125715748, 728.1989811207629, 763.3130182835492, 9305.0, 9581.425114493153, 9662.806743865083, 9756.414615123116, 9774.071463210983, 701.9122609673791, 715.989260161098, 725.793148952546, 734.4381548115696, 738.9113306403266, 4328.156009578102, 4436.556344365537, 4477.0, 4479.686421950432, 4500.527444618333, 61559.38440615537, 61957.38042619516, 62442.0, 62500.374996250364, 63314.366856330846, 54529.1820622691, 55452.44547554554, 55486.0, 55648.44351556433, 55836.72081639566, 48839.0, 49143.50856491389, 49318.50681493211, 49366.75316623466, 51287.74356128195, 9441.339106262496, 9486.573104210465, 9531.761705957406, 9638.855417168888, 10121.291509594257, 37405.6259437413, 37622.43566346452, 37991.81004094962, 38674.6132538671, 39235.2152956945, 46350.30474542952, 47384.7630761844, 47694.28458573193, 48180.5181948176, 48772.0, 12096.939515302367, 12313.692157696129, 12369.62891113268, 12423.378831058591, 12553.686157846127, 13020.804687929878, 13079.476820927057, 13134.60596182116, 13162.934185329395, 13232.206067635972, 11371.374574398156, 11654.825177622173, 11985.460654270404, 11992.820107698566, 12581.811272830731, 12575.0, 12694.809577856155, 12711.682207944505, 12930.676733081747, 13223.206607603575, 12453.875461245272, 12613.936930315289, 12754.936225318814, 13041.608751737464, 13215.537456188988, 10101.14140298083, 10180.847939388834, 10182.185425166117, 10277.383356998604, 10848.67453976382, 10887.673369798918, 10902.50938707776, 11057.281276716987, 11074.778504429705, 11080.667579972614], "unit": "score", "name": "yui.html", "value": 7068.543737986345}], "name": "dromaeo_css", "value": 7437.906194035551}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 109.0, 109.0, 112.0, 121.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 157.0, 172.0, 133.0, 172.0, 150.0, 134.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 163.0, 163.0, 163.0, 164.0, 161.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [71.0, 77.0, 73.0, 155.0, 75.0, 75.0, 75.0, 72.0, 160.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 139.0, 92.0, 92.0, 92.0, 140.0, 93.0, 92.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 56.0, 56.0, 56.0, 57.0, 55.0, 63.0, 63.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 67.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 86.0, 80.0, 80.0, 79.0, 80.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 115.0, 112.0, 112.0, 118.0, 117.0, 112.0, 115.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.5}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 149.0, 145.0, 133.0, 133.0, 147.0, 143.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 66.0, 65.0, 67.0, 74.0, 69.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1505.3999999999999}]} 17:10:40 INFO - Return code: 0 17:10:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:40 ERROR - # TBPL SUCCESS # 17:10:40 INFO - Running post-action listener: _resource_record_post_action 17:10:40 INFO - Running post-run listener: _resource_record_post_run 17:10:41 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 269115392; Read time: 28; Write time: 169244 17:10:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14278656; Read time: 0; Write time: 2752 17:10:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254836736; Read time: 28; Write time: 166492 17:10:41 INFO - Running post-run listener: _upload_blobber_files 17:10:41 INFO - Blob upload gear active. 17:10:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:10:41 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 17:10:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:10:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:10:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:10:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:10:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:43 INFO - (blobuploader) - INFO - Done attempting. 17:10:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:10:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:43 INFO - (blobuploader) - INFO - Done attempting. 17:10:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:10:43 INFO - Return code: 0 17:10:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:10:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:10:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a13762036c5a20bb85e5db510f81f641e072bcdafe7d52bf2e423c83d216874f5cd762db9dc38e9870ca57ede4779685119b94beed47835e25f335daf55c9c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40d0ff0c58d8c6c932557bf87e79a09f60f2e0ae7e7d2207db4bad3d2b7a58a4bb58aa4e13143e220af463e64da3f72cb83302c9768e85e8ccb56036b7476d85"} 17:10:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:10:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:10:43 INFO - Contents: 17:10:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a13762036c5a20bb85e5db510f81f641e072bcdafe7d52bf2e423c83d216874f5cd762db9dc38e9870ca57ede4779685119b94beed47835e25f335daf55c9c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40d0ff0c58d8c6c932557bf87e79a09f60f2e0ae7e7d2207db4bad3d2b7a58a4bb58aa4e13143e220af463e64da3f72cb83302c9768e85e8ccb56036b7476d85"} 17:10:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:10:43 INFO - Copying logs to upload dir... 17:10:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:10:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.236918 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-21 17:10:43.935170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 17:10:43.938483) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a13762036c5a20bb85e5db510f81f641e072bcdafe7d52bf2e423c83d216874f5cd762db9dc38e9870ca57ede4779685119b94beed47835e25f335daf55c9c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40d0ff0c58d8c6c932557bf87e79a09f60f2e0ae7e7d2207db4bad3d2b7a58a4bb58aa4e13143e220af463e64da3f72cb83302c9768e85e8ccb56036b7476d85"} build_url:https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/PKpp4A-nS-i_B2up6sq_rg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a13762036c5a20bb85e5db510f81f641e072bcdafe7d52bf2e423c83d216874f5cd762db9dc38e9870ca57ede4779685119b94beed47835e25f335daf55c9c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40d0ff0c58d8c6c932557bf87e79a09f60f2e0ae7e7d2207db4bad3d2b7a58a4bb58aa4e13143e220af463e64da3f72cb83302c9768e85e8ccb56036b7476d85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 17:10:43.963731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 17:10:43.964078) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458601347.760458-150197405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 17:10:44.048144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 17:10:44.048470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 17:10:44.048799) ========= ========= Total master_lag: 0.32 =========