builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1459980030.01 results: success (0) buildid: 20160406122111 builduid: b61b7c1fd3b14a67aaf14767a2fdb8b4 revision: af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.010945) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.011683) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.011977) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.034832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.035120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.048257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.048524) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.098113) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.098428) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.098780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.099052) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 15:00:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-04-06 15:00:30 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.284540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.284850) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022694 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.333952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:30.334307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 --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 af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 --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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 15:00:30,981 truncating revision to first 12 chars 2016-04-06 15:00:30,981 Setting DEBUG logging. 2016-04-06 15:00:30,981 attempt 1/10 2016-04-06 15:00:30,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af4e1dc2e458?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 15:00:31,472 unpacking tar archive at: mozilla-aurora-af4e1dc2e458/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:31.179474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:31.179773) ========= echo af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28'] 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 program finished with exit code 0 elapsedTime=0.004296 script_repo_revision: 'af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:31.232140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:31.232456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:00:31.243804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 15 secs) (at 2016-04-06 15:00:31.244088) ========= /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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:31 INFO - MultiFileLogger online at 20160406 15:00:31 in /builds/slave/test-pgo 15:00:31 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 15:00:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:00:31 INFO - {'append_to_log': False, 15:00:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:00:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:00:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:00:31 INFO - 'branch': 'Mozilla-Aurora', 15:00:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:31 INFO - 'config_files': ('talos/linux_config.py',), 15:00:31 INFO - 'default_actions': ('clobber', 15:00:31 INFO - 'read-buildbot-config', 15:00:31 INFO - 'download-and-extract', 15:00:31 INFO - 'populate-webroot', 15:00:31 INFO - 'create-virtualenv', 15:00:31 INFO - 'install', 15:00:31 INFO - 'run-tests'), 15:00:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:31 INFO - 'download_minidump_stackwalk': True, 15:00:31 INFO - 'download_symbols': 'ondemand', 15:00:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:31 INFO - 'installer_path': 'installer.exe', 15:00:31 INFO - 'log_level': 'info', 15:00:31 INFO - 'log_name': 'talos', 15:00:31 INFO - 'log_to_console': True, 15:00:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:31 INFO - 'opt_config_files': (), 15:00:31 INFO - 'pip_index': False, 15:00:31 INFO - 'sps_profile': False, 15:00:31 INFO - 'sps_profile_interval': 0, 15:00:31 INFO - 'suite': 'dromaeojs-e10s', 15:00:31 INFO - 'system_bits': '32', 15:00:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:31 INFO - 'title': 'talos-linux64-ix-002', 15:00:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:31 INFO - 'use_talos_json': True, 15:00:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:00:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:31 INFO - 'work_dir': 'build'} 15:00:31 INFO - ##### 15:00:31 INFO - ##### Running clobber step. 15:00:31 INFO - ##### 15:00:31 INFO - Running pre-action listener: _resource_record_pre_action 15:00:31 INFO - Running main action method: clobber 15:00:31 INFO - rmtree: /builds/slave/test-pgo/build 15:00:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:00:32 INFO - Running post-action listener: _resource_record_post_action 15:00:32 INFO - ##### 15:00:32 INFO - ##### Running read-buildbot-config step. 15:00:32 INFO - ##### 15:00:32 INFO - Running pre-action listener: _resource_record_pre_action 15:00:32 INFO - Running main action method: read_buildbot_config 15:00:32 INFO - Using buildbot properties: 15:00:32 INFO - { 15:00:32 INFO - "project": "", 15:00:32 INFO - "product": "firefox", 15:00:32 INFO - "script_repo_revision": "production", 15:00:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:00:32 INFO - "repository": "", 15:00:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:00:32 INFO - "buildid": "20160406122111", 15:00:32 INFO - "pgo_build": "True", 15:00:32 INFO - "basedir": "/builds/slave/test-pgo", 15:00:32 INFO - "buildnumber": 230, 15:00:32 INFO - "slavename": "talos-linux64-ix-002", 15:00:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:00:32 INFO - "platform": "ubuntu64_hw", 15:00:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:00:32 INFO - "branch": "mozilla-aurora", 15:00:32 INFO - "repo_path": "releases/mozilla-aurora", 15:00:32 INFO - "revision": "af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28", 15:00:32 INFO - "stage_platform": "linux64-pgo", 15:00:32 INFO - "builduid": "b61b7c1fd3b14a67aaf14767a2fdb8b4", 15:00:32 INFO - "slavebuilddir": "test" 15:00:32 INFO - } 15:00:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:00:32 INFO - Running post-action listener: _resource_record_post_action 15:00:32 INFO - ##### 15:00:32 INFO - ##### Running download-and-extract step. 15:00:32 INFO - ##### 15:00:32 INFO - Running pre-action listener: _resource_record_pre_action 15:00:32 INFO - Running main action method: download_and_extract 15:00:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:00: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')]} 15:00:32 INFO - https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:00:35 INFO - Downloaded 1448 bytes. 15:00:35 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:00:35 INFO - Using the following test package requirements: 15:00:35 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:00:35 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:00:35 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:00:35 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'jsshell-linux-x86_64.zip'], 15:00:35 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:00:35 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:00:35 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:00:35 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:00:35 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:00:35 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:00:35 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:00:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:00: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')]} 15:00:35 INFO - https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:00:37 INFO - Downloaded 23345436 bytes. 15:00:37 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'] 15:00:37 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 15:00:39 INFO - Return code: 0 15:00:39 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 15:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:39 INFO - https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:12:18 INFO - Downloaded 23345436 bytes. 15:12:18 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'] 15:12:18 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 15:12:19 INFO - Return code: 0 15:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:19 INFO - https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:12:21 INFO - Downloaded 10845161 bytes. 15:12:21 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'] 15:12:21 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 15:12:21 INFO - Return code: 0 15:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:21 INFO - https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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 15:12:30 INFO - Downloaded 60564527 bytes. 15:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:12:30 INFO - mkdir: /builds/slave/test-pgo/properties 15:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:12:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:12:30 INFO - Contents: 15:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:12:31 INFO - Running post-action listener: _resource_record_post_action 15:12:31 INFO - Running post-action listener: set_extra_try_arguments 15:12:31 INFO - ##### 15:12:31 INFO - ##### Running populate-webroot step. 15:12:31 INFO - ##### 15:12:31 INFO - Running pre-action listener: _resource_record_pre_action 15:12:31 INFO - Running main action method: populate_webroot 15:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:31 INFO - '--tppagecycles', 15:12:31 INFO - '7'], 15:12:31 INFO - 'tests': ['tsvgm']}}, 15:12:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:12:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:12:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['damp', 'tps']}, 15:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['damp', 'tps']}, 15:12:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:12:31 INFO - 'other': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other_l64': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other_nol64': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'svgr': {'tests': ['tsvgx', 15:12:31 INFO - 'tsvgr_opacity', 15:12:31 INFO - 'tart', 15:12:31 INFO - 'tscrollx', 15:12:31 INFO - 'cart']}, 15:12:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['tsvgx', 15:12:31 INFO - 'tsvgr_opacity', 15:12:31 INFO - 'tart', 15:12:31 INFO - 'tscrollx', 15:12:31 INFO - 'cart']}, 15:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['tp5o']}, 15:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--e10s'], 15:12:31 INFO - 'tests': ['tp5o']}, 15:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--xperf_path', 15:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:31 INFO - 'tests': ['tp5n']}, 15:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--e10s', 15:12:31 INFO - '--xperf_path', 15:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:31 INFO - 'tests': ['tp5n']}}, 15:12:31 INFO - 'talos.zip': {'path': '', 15:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:31 INFO - Running post-action listener: _resource_record_post_action 15:12:31 INFO - ##### 15:12:31 INFO - ##### Running create-virtualenv step. 15:12:31 INFO - ##### 15:12:31 INFO - Running pre-action listener: _resource_record_pre_action 15:12:31 INFO - Running main action method: create_virtualenv 15:12:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:12:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:31 INFO - Using real prefix '/usr' 15:12:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:34 INFO - Installing pip.................done. 15:12:34 INFO - Return code: 0 15:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:34 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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:12:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:12:34 INFO - Using env: {'DISPLAY': ':0', 15:12:34 INFO - 'HOME': '/home/cltbld', 15:12:34 INFO - 'LANG': 'en_US.UTF-8', 15:12:34 INFO - 'LANGUAGE': 'en_US:en', 15:12:34 INFO - 'LOGNAME': 'cltbld', 15:12:34 INFO - 'MAIL': '/var/mail/cltbld', 15:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:34 INFO - 'MOZ_NO_REMOTE': '1', 15:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:34 INFO - 'NO_EM_RESTART': '1', 15:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:34 INFO - 'SHELL': '/bin/bash', 15:12:34 INFO - 'SHLVL': '1', 15:12:34 INFO - 'TERM': 'linux', 15:12:34 INFO - 'TMOUT': '86400', 15:12:34 INFO - 'USER': 'cltbld', 15:12:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:34 INFO - '_': '/tools/buildbot/bin/python'} 15:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:12:34 INFO - Cleaning up... 15:12:34 INFO - Return code: 0 15:12:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:34 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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:12:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:12:34 INFO - Using env: {'DISPLAY': ':0', 15:12:34 INFO - 'HOME': '/home/cltbld', 15:12:34 INFO - 'LANG': 'en_US.UTF-8', 15:12:34 INFO - 'LANGUAGE': 'en_US:en', 15:12:34 INFO - 'LOGNAME': 'cltbld', 15:12:34 INFO - 'MAIL': '/var/mail/cltbld', 15:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:34 INFO - 'MOZ_NO_REMOTE': '1', 15:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:34 INFO - 'NO_EM_RESTART': '1', 15:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:34 INFO - 'SHELL': '/bin/bash', 15:12:34 INFO - 'SHLVL': '1', 15:12:34 INFO - 'TERM': 'linux', 15:12:34 INFO - 'TMOUT': '86400', 15:12:34 INFO - 'USER': 'cltbld', 15:12:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:34 INFO - '_': '/tools/buildbot/bin/python'} 15:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:34 INFO - Downloading/unpacking psutil>=0.7.1 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:36 INFO - Installing collected packages: psutil 15:12:36 INFO - Running setup.py install for psutil 15:12:36 INFO - building 'psutil._psutil_linux' extension 15:12:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:12:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:12:37 INFO - building 'psutil._psutil_posix' extension 15:12:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:12:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:37 INFO - Successfully installed psutil 15:12:37 INFO - Cleaning up... 15:12:37 INFO - Return code: 0 15:12:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:37 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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:12:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:12:37 INFO - Using env: {'DISPLAY': ':0', 15:12:37 INFO - 'HOME': '/home/cltbld', 15:12:37 INFO - 'LANG': 'en_US.UTF-8', 15:12:37 INFO - 'LANGUAGE': 'en_US:en', 15:12:37 INFO - 'LOGNAME': 'cltbld', 15:12:37 INFO - 'MAIL': '/var/mail/cltbld', 15:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:37 INFO - 'MOZ_NO_REMOTE': '1', 15:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:37 INFO - 'NO_EM_RESTART': '1', 15:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:37 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:37 INFO - 'SHELL': '/bin/bash', 15:12:37 INFO - 'SHLVL': '1', 15:12:37 INFO - 'TERM': 'linux', 15:12:37 INFO - 'TMOUT': '86400', 15:12:37 INFO - 'USER': 'cltbld', 15:12:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:37 INFO - '_': '/tools/buildbot/bin/python'} 15:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:12:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:12:39 INFO - Installing collected packages: mozsystemmonitor 15:12:39 INFO - Running setup.py install for mozsystemmonitor 15:12:39 INFO - Successfully installed mozsystemmonitor 15:12:39 INFO - Cleaning up... 15:12:39 INFO - Return code: 0 15:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:12:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:12:39 INFO - Using env: {'DISPLAY': ':0', 15:12:39 INFO - 'HOME': '/home/cltbld', 15:12:39 INFO - 'LANG': 'en_US.UTF-8', 15:12:39 INFO - 'LANGUAGE': 'en_US:en', 15:12:39 INFO - 'LOGNAME': 'cltbld', 15:12:39 INFO - 'MAIL': '/var/mail/cltbld', 15:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:39 INFO - 'MOZ_NO_REMOTE': '1', 15:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:39 INFO - 'NO_EM_RESTART': '1', 15:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:39 INFO - 'SHELL': '/bin/bash', 15:12:39 INFO - 'SHLVL': '1', 15:12:39 INFO - 'TERM': 'linux', 15:12:39 INFO - 'TMOUT': '86400', 15:12:39 INFO - 'USER': 'cltbld', 15:12:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:39 INFO - '_': '/tools/buildbot/bin/python'} 15:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:12:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:42 INFO - Downloading docopt-0.6.1.tar.gz 15:12:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:42 INFO - Running setup.py install for blobuploader 15:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:12:42 INFO - Running setup.py install for requests 15:12:42 INFO - Running setup.py install for docopt 15:12:42 INFO - Successfully installed blobuploader requests docopt 15:12:42 INFO - Cleaning up... 15:12:43 INFO - Return code: 0 15:12:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:43 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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:12:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:43 INFO - Using env: {'DISPLAY': ':0', 15:12:43 INFO - 'HOME': '/home/cltbld', 15:12:43 INFO - 'LANG': 'en_US.UTF-8', 15:12:43 INFO - 'LANGUAGE': 'en_US:en', 15:12:43 INFO - 'LOGNAME': 'cltbld', 15:12:43 INFO - 'MAIL': '/var/mail/cltbld', 15:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:43 INFO - 'MOZ_NO_REMOTE': '1', 15:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:43 INFO - 'NO_EM_RESTART': '1', 15:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:43 INFO - 'SHELL': '/bin/bash', 15:12:43 INFO - 'SHLVL': '1', 15:12:43 INFO - 'TERM': 'linux', 15:12:43 INFO - 'TMOUT': '86400', 15:12:43 INFO - 'USER': 'cltbld', 15:12:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:43 INFO - '_': '/tools/buildbot/bin/python'} 15:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:12:43 INFO - Running setup.py (path:/tmp/pip-uAryci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:12:43 INFO - Running setup.py (path:/tmp/pip-giVcUc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:12:43 INFO - Running setup.py (path:/tmp/pip-KaFMyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:12:43 INFO - Running setup.py (path:/tmp/pip-rirQHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:12:43 INFO - Running setup.py (path:/tmp/pip-1oD5W7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:12:43 INFO - Running setup.py (path:/tmp/pip-jlUwQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:12:43 INFO - Running setup.py (path:/tmp/pip-KyyGwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:12:43 INFO - Running setup.py (path:/tmp/pip-oPYptu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:12:43 INFO - Running setup.py (path:/tmp/pip-gAJA8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:12:43 INFO - Running setup.py (path:/tmp/pip-Dz9Lf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:12:43 INFO - Running setup.py (path:/tmp/pip-Otmha1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:12:44 INFO - Running setup.py (path:/tmp/pip-vjCtws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:12:44 INFO - Running setup.py (path:/tmp/pip-RfMKl5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:12:44 INFO - Running setup.py (path:/tmp/pip-CI5Tcg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:12:44 INFO - Running setup.py (path:/tmp/pip-W_pBPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:12:44 INFO - Running setup.py (path:/tmp/pip-G84X3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:12:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:12:44 INFO - Running setup.py (path:/tmp/pip-aH1xjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:44 INFO - Running setup.py install for manifestparser 15:12:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:12:44 INFO - Running setup.py install for mozcrash 15:12:44 INFO - Running setup.py install for mozdebug 15:12:44 INFO - Running setup.py install for mozdevice 15:12:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:12:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:12:44 INFO - Running setup.py install for mozfile 15:12:44 INFO - Running setup.py install for mozhttpd 15:12:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozinfo 15:12:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozInstall 15:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozleak 15:12:45 INFO - Running setup.py install for mozlog 15:12:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for moznetwork 15:12:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozprocess 15:12:45 INFO - Running setup.py install for mozprofile 15:12:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozrunner 15:12:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:12:45 INFO - Running setup.py install for mozscreenshot 15:12:46 INFO - Running setup.py install for moztest 15:12:46 INFO - Running setup.py install for mozversion 15:12:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:46 INFO - Cleaning up... 15:12:46 INFO - Return code: 0 15:12:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:12: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')]} 15:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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/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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:12:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:46 INFO - Using env: {'DISPLAY': ':0', 15:12:46 INFO - 'HOME': '/home/cltbld', 15:12:46 INFO - 'LANG': 'en_US.UTF-8', 15:12:46 INFO - 'LANGUAGE': 'en_US:en', 15:12:46 INFO - 'LOGNAME': 'cltbld', 15:12:46 INFO - 'MAIL': '/var/mail/cltbld', 15:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:46 INFO - 'MOZ_NO_REMOTE': '1', 15:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:46 INFO - 'NO_EM_RESTART': '1', 15:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:46 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:46 INFO - 'SHELL': '/bin/bash', 15:12:46 INFO - 'SHLVL': '1', 15:12:46 INFO - 'TERM': 'linux', 15:12:46 INFO - 'TMOUT': '86400', 15:12:46 INFO - 'USER': 'cltbld', 15:12:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:46 INFO - '_': '/tools/buildbot/bin/python'} 15:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:12:46 INFO - Running setup.py (path:/tmp/pip-fAT5gJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:12:46 INFO - Running setup.py (path:/tmp/pip-U27G1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:12:46 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)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:12:46 INFO - Running setup.py (path:/tmp/pip-O3gtDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:12:46 INFO - Running setup.py (path:/tmp/pip-JFlB4y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:12:46 INFO - Running setup.py (path:/tmp/pip-JYtTug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:12:46 INFO - Running setup.py (path:/tmp/pip-Ve9tFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:12:46 INFO - Running setup.py (path:/tmp/pip-4i0vxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:12:46 INFO - Running setup.py (path:/tmp/pip-QVtYZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:12:47 INFO - Running setup.py (path:/tmp/pip-oZDfLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:12:47 INFO - Running setup.py (path:/tmp/pip-FYM5c7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:12:47 INFO - Running setup.py (path:/tmp/pip-lefbuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:12:47 INFO - Running setup.py (path:/tmp/pip-OeCRKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:12:47 INFO - Running setup.py (path:/tmp/pip-98Jbmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:12:47 INFO - Running setup.py (path:/tmp/pip-BSFowc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:12:47 INFO - Running setup.py (path:/tmp/pip-nnqgTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:12:47 INFO - Running setup.py (path:/tmp/pip-wE2HBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:12:47 INFO - Running setup.py (path:/tmp/pip-32hdND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:12:47 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)) 15:12:47 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)) 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:49 INFO - Downloading blessings-1.6.tar.gz 15:12:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:49 INFO - Installing collected packages: blessings 15:12:49 INFO - Running setup.py install for blessings 15:12:49 INFO - Successfully installed blessings 15:12:49 INFO - Cleaning up... 15:12:50 INFO - Return code: 0 15:12:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:12:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:12:50 INFO - Reading from file tmpfile_stdout 15:12:50 INFO - Current package versions: 15:12:50 INFO - argparse == 1.2.1 15:12:50 INFO - blessings == 1.6 15:12:50 INFO - blobuploader == 1.2.4 15:12:50 INFO - docopt == 0.6.1 15:12:50 INFO - manifestparser == 1.1 15:12:50 INFO - mozInstall == 1.12 15:12:50 INFO - mozcrash == 0.17 15:12:50 INFO - mozdebug == 0.1 15:12:50 INFO - mozdevice == 0.48 15:12:50 INFO - mozfile == 1.2 15:12:50 INFO - mozhttpd == 0.7 15:12:50 INFO - mozinfo == 0.9 15:12:50 INFO - mozleak == 0.1 15:12:50 INFO - mozlog == 3.1 15:12:50 INFO - moznetwork == 0.27 15:12:50 INFO - mozprocess == 0.22 15:12:50 INFO - mozprofile == 0.28 15:12:50 INFO - mozrunner == 6.11 15:12:50 INFO - mozscreenshot == 0.1 15:12:50 INFO - mozsystemmonitor == 0.0 15:12:50 INFO - moztest == 0.7 15:12:50 INFO - mozversion == 1.4 15:12:50 INFO - psutil == 3.1.1 15:12:50 INFO - requests == 1.2.3 15:12:50 INFO - wsgiref == 0.1.2 15:12:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:12: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')]} 15:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:50 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 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:50 INFO - Using env: {'DISPLAY': ':0', 15:12:50 INFO - 'HOME': '/home/cltbld', 15:12:50 INFO - 'LANG': 'en_US.UTF-8', 15:12:50 INFO - 'LANGUAGE': 'en_US:en', 15:12:50 INFO - 'LOGNAME': 'cltbld', 15:12:50 INFO - 'MAIL': '/var/mail/cltbld', 15:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:50 INFO - 'MOZ_NO_REMOTE': '1', 15:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:50 INFO - 'NO_EM_RESTART': '1', 15:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:50 INFO - 'SHELL': '/bin/bash', 15:12:50 INFO - 'SHLVL': '1', 15:12:50 INFO - 'TERM': 'linux', 15:12:50 INFO - 'TMOUT': '86400', 15:12:50 INFO - 'USER': 'cltbld', 15:12:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:50 INFO - '_': '/tools/buildbot/bin/python'} 15:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:12:50 INFO - Cleaning up... 15:12:50 INFO - Return code: 0 15:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:12: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')]} 15:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12: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', 'jsonschema'] in /builds/slave/test-pgo/build 15:12: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 jsonschema 15:12:50 INFO - Using env: {'DISPLAY': ':0', 15:12:50 INFO - 'HOME': '/home/cltbld', 15:12:50 INFO - 'LANG': 'en_US.UTF-8', 15:12:50 INFO - 'LANGUAGE': 'en_US:en', 15:12:50 INFO - 'LOGNAME': 'cltbld', 15:12:50 INFO - 'MAIL': '/var/mail/cltbld', 15:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:50 INFO - 'MOZ_NO_REMOTE': '1', 15:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:50 INFO - 'NO_EM_RESTART': '1', 15:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:50 INFO - 'SHELL': '/bin/bash', 15:12:50 INFO - 'SHLVL': '1', 15:12:50 INFO - 'TERM': 'linux', 15:12:50 INFO - 'TMOUT': '86400', 15:12:50 INFO - 'USER': 'cltbld', 15:12:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:50 INFO - '_': '/tools/buildbot/bin/python'} 15:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:50 INFO - Downloading/unpacking jsonschema 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:52 INFO - Downloading/unpacking functools32 (from jsonschema) 15:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:52 INFO - warning: no files found matching '*.txt' 15:12:52 INFO - no previously-included directories found matching 'build' 15:12:52 INFO - no previously-included directories found matching 'dist' 15:12:52 INFO - no previously-included directories found matching '.git*' 15:12:52 INFO - Installing collected packages: jsonschema, functools32 15:12:52 INFO - Running setup.py install for functools32 15:12:53 INFO - warning: no files found matching '*.txt' 15:12:53 INFO - no previously-included directories found matching 'build' 15:12:53 INFO - no previously-included directories found matching 'dist' 15:12:53 INFO - no previously-included directories found matching '.git*' 15:12:53 INFO - Successfully installed jsonschema functools32 15:12:53 INFO - Cleaning up... 15:12:53 INFO - Return code: 0 15:12:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e2b36af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:12:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:12:53 INFO - Using env: {'DISPLAY': ':0', 15:12:53 INFO - 'HOME': '/home/cltbld', 15:12:53 INFO - 'LANG': 'en_US.UTF-8', 15:12:53 INFO - 'LANGUAGE': 'en_US:en', 15:12:53 INFO - 'LOGNAME': 'cltbld', 15:12:53 INFO - 'MAIL': '/var/mail/cltbld', 15:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:53 INFO - 'MOZ_NO_REMOTE': '1', 15:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:53 INFO - 'NO_EM_RESTART': '1', 15:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:12:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:12:53 INFO - 'SHELL': '/bin/bash', 15:12:53 INFO - 'SHLVL': '1', 15:12:53 INFO - 'TERM': 'linux', 15:12:53 INFO - 'TMOUT': '86400', 15:12:53 INFO - 'USER': 'cltbld', 15:12:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:53 INFO - '_': '/tools/buildbot/bin/python'} 15:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:53 INFO - Downloading/unpacking flake8 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:12:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:12:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:12:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:56 INFO - no previously-included directories found matching 'docs/_build' 15:12:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:12:56 INFO - Running setup.py install for pep8 15:12:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:56 INFO - no previously-included directories found matching 'docs/_build' 15:12:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:12:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:12:56 INFO - Cleaning up... 15:12:56 INFO - Return code: 0 15:12:56 INFO - Running post-action listener: _resource_record_post_action 15:12:56 INFO - Running post-action listener: _start_resource_monitoring 15:12:56 INFO - Starting resource monitoring. 15:12:56 INFO - ##### 15:12:56 INFO - ##### Running install step. 15:12:56 INFO - ##### 15:12:56 INFO - Running pre-action listener: _resource_record_pre_action 15:12:56 INFO - Running main action method: install 15:12:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:12:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:12:56 INFO - Reading from file tmpfile_stdout 15:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:12:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:12:57 INFO - Reading from file tmpfile_stdout 15:12:57 INFO - Output received: 15:12:57 INFO - Usage: mozinstall [options] installer 15:12:57 INFO - Options: 15:12:57 INFO - -h, --help show this help message and exit 15:12:57 INFO - -d DEST, --destination=DEST 15:12:57 INFO - Directory to install application into. [default: 15:12:57 INFO - "/builds/slave/test-pgo"] 15:12:57 INFO - --app=APP Application being installed. [default: firefox] 15:12:57 INFO - mkdir: /builds/slave/test-pgo/build/application 15:12:57 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'] 15:12:57 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 15:13:12 INFO - Reading from file tmpfile_stdout 15:13:12 INFO - Output received: 15:13:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:13:12 INFO - Running post-action listener: _resource_record_post_action 15:13:12 INFO - ##### 15:13:12 INFO - ##### Running run-tests step. 15:13:12 INFO - ##### 15:13:12 INFO - Running pre-action listener: _resource_record_pre_action 15:13:12 INFO - Running main action method: run_tests 15:13:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:13:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:13:12 INFO - Python 2.7.3 15:13:12 INFO - Return code: 0 15:13:12 INFO - grabbing minidump binary from tooltool 15:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:12 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 0x2061920>, '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 0x2062820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2062cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:13:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:13:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:13:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:12 INFO - Return code: 0 15:13:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:13:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:13:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:13:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:13:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:13:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:13:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:13:13 INFO - Return code: 0 15:13:13 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/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:13:13 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/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 15:13:13 INFO - Using env: {'DISPLAY': ':0', 15:13:13 INFO - 'HOME': '/home/cltbld', 15:13:13 INFO - 'LANG': 'en_US.UTF-8', 15:13:13 INFO - 'LANGUAGE': 'en_US:en', 15:13:13 INFO - 'LOGNAME': 'cltbld', 15:13:13 INFO - 'MAIL': '/var/mail/cltbld', 15:13:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:13:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:13 INFO - 'MOZ_NO_REMOTE': '1', 15:13:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:13 INFO - 'NO_EM_RESTART': '1', 15:13:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:13:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:13:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:13:13 INFO - 'SHELL': '/bin/bash', 15:13:13 INFO - 'SHLVL': '1', 15:13:13 INFO - 'TERM': 'linux', 15:13:13 INFO - 'TMOUT': '86400', 15:13:13 INFO - 'USER': 'cltbld', 15:13:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861', 15:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:13 INFO - '_': '/tools/buildbot/bin/python'} 15:13:13 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/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:13:13 INFO - mozversion application_buildid: 20160406122111 15:13:13 INFO - mozversion application_changeset: af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 15:13:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:13:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:13 INFO - mozversion application_name: Firefox 15:13:13 INFO - mozversion application_remotingname: firefox-dev 15:13:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:13 INFO - mozversion application_vendor: Mozilla 15:13:13 INFO - mozversion application_version: 47.0a2 15:13:13 INFO - mozversion platform_buildid: 20160406122111 15:13:13 INFO - mozversion platform_changeset: af4e1dc2e4589cccaa30a2a6b41fbb65abef8b28 15:13:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:13 INFO - mozversion platform_version: 47.0a2 15:13:13 INFO - using testdate: 1459980793 15:13:13 INFO - actual date: 1459980793 15:13:13 INFO - starting webserver on 'localhost:51513' 15:13:13 INFO - SUITE-START | Running 2 tests 15:13:13 INFO - TEST-START | dromaeo_css 15:13:13 INFO - operating with platform_type : linux_ 15:13:13 INFO - Initialising browser for dromaeo_css test... 15:13:13 INFO - TEST-INFO | started process 4396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2xiB2b/profile http://localhost:51513/getInfo.html) 15:13:17 INFO - PROCESS | 4396 | 15:13:17 INFO - PROCESS | 4396 | (process:4474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:17 INFO - PROCESS | 4396 | __metrics Screen width/height:1600/1200 15:13:17 INFO - PROCESS | 4396 | colorDepth:24 15:13:17 INFO - PROCESS | 4396 | Browser inner width/height: 1024/697 15:13:17 INFO - PROCESS | 4396 | __metrics 15:13:18 ERROR - PROCESS | 4396 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:13:19 INFO - TEST-INFO | 4396: exit 0 15:13:19 INFO - Browser initialized. 15:13:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:19 INFO - TEST-INFO | started process 4525 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2xiB2b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:21 INFO - PROCESS | 4525 | 15:13:21 INFO - PROCESS | 4525 | (process:4592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:31 INFO - PROCESS | 4525 | RSS: Main: 151801856 15:13:31 INFO - PROCESS | 4525 | 15:14:20 INFO - PROCESS | 4525 | 1459980860886 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] 15:16:28 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51513/tests/dromaeo/cssquery-ext.html) 15:16:29 INFO - PROCESS | 4525 | RSS: Main: 154841088 15:16:29 INFO - PROCESS | 4525 | 15:19:31 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-ext.html (next: http://localhost:51513/tests/dromaeo/cssquery-jquery.html) 15:19:32 INFO - PROCESS | 4525 | RSS: Main: 153464832 15:19:32 INFO - PROCESS | 4525 | 15:22:34 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51513/tests/dromaeo/cssquery-mootools.html) 15:22:34 INFO - PROCESS | 4525 | RSS: Main: 153432064 15:22:34 INFO - PROCESS | 4525 | 15:25:36 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51513/tests/dromaeo/cssquery-prototype.html) 15:25:37 INFO - PROCESS | 4525 | RSS: Main: 151961600 15:25:37 INFO - PROCESS | 4525 | 15:28:39 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51513/tests/dromaeo/cssquery-yui.html) 15:28:39 INFO - PROCESS | 4525 | RSS: Main: 153731072 15:28:39 INFO - PROCESS | 4525 | 15:31:41 INFO - PROCESS | 4525 | Cycle 1(1): loaded http://localhost:51513/tests/dromaeo/cssquery-yui.html (next: http://localhost:51513/tests/dromaeo/cssquery-dojo.html) 15:31:42 INFO - PROCESS | 4525 | RSS: Main: 155078656 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | __start_tp_report 15:31:42 INFO - PROCESS | 4525 | _x_x_mozilla_page_load 15:31:42 INFO - PROCESS | 4525 | _x_x_mozilla_page_load_details 15:31:42 INFO - PROCESS | 4525 | |i|pagename|runs| 15:31:42 INFO - PROCESS | 4525 | |0;dojo.html;3267.7875938064026;3325.102222399951;3332.716719078878;3343.465045592706;3359.1770016346;5492.697901615415;5511;5527.751251193696;5528.75120619572;5543.279373681421;5509.228707980886;5515.338159420865;5516.255305533752;5541.944580554194;5550.16747487877;5035.068512325213;5066.822661206858;5136;5144.09978253806;5150.459201783815;4958.652894297401;5067.467915868836;5109.054824857395;5138.5889128869785;5160.92258616121;5026.597872170218;5036.546710796028;5073.112205364065;5101.6683915545555;5137;5134.4095429025765;5135.897282054357;5138.665986710852;5138.922916156261;5150.97424512875;4785.3300537924715;4874.049560335736;5115.769790359443;5131.640785145041;5160.8193713220235;5348.652337598043;5366.195070739382;5376.166694162411;5384;5385.246065550826;5915.408459154093;5954.374790646963;5955.255593050869;5969.134475501028;5969.373215812364;5995.7901473448655;6014.338422773491;6067.544934129958;6083.878322433527;6089.695515224265;5620.634658747168;5637.041702910515;5637.943620563783;5644.266245388114;5648.943510564924;5840.970795145997;6113.480354169946;6126;6139.171211886427;6147.200863887666;5782.566307526952;5842.941570584325;5849.736761845727;5851.941480585225;5861.384554621789;6006.369331220247;6013.037913933749;6018.578699490994;6027.397260273938;6029.155918171459;5847.152162936351;5877.617954832922;5948.940510594925;5959.344472108065;5973.342932277446;5927.614705044159;5930.05119180929;5930.466258036798;5944.256967879015;5970.820875373659;4481.932771008437;4503.369528266046;4511.323301504801;4514.255147900625;4538.52345503724;3990.4014397840556;4014.7992600369867;4043.0498832774274;4055.6958228133008;4057.9391309130388;5594.328680558359;5630.465105814941;5680.573956953162;5688.23208866806;5696.544276457874;5990.73041713124;5995.190649262381;6017.669028203491;6020.849478763066;6056.212692350055;5601.887962240814;5679.886402271932;5690.715464226772;5695.572832037614;5699.458551437607;5118.795248190105;5155.329807125125;5169.121249387613;5187.636865419385;5208.218767184952;6058.90911636317;6077.604955677867;6087.726052327655;6093;6110.908336374958;5810.157527158453;5923.378045305181;6005.90991135142;6006.909896351471;6008.128821320972;5985.132155837467;6094.908576371269;6110.51115910735;6114.540688159306;6134.631922084689;5930.229070220844;5937.435943585352;5939.316978547522;5944.494717949023;5953.166556681981;5710.600257981901;5953.6427814329545;6023.518118550418;6036.456718895145;6048.274207095177;5842.444967728059;5855.824325270249;5858.209141765978;5865.472107510344;5882.23530940975;5824.242848429677;5841.036229022334;5843.181954526454;5847.8538036547725;5884.970130227279;5625.803096891589;5739.512141468022;5745.885082298414;5827.970860145672;5847.678377689268;5870.9432302184305;5927.940720592911;5936.910946335895;5950.702464876826;5955.851103722268;5854.414558544111;5867.149263356875;5868.67722275279;5877.882442351043;5878.529717622666 15:31:42 INFO - PROCESS | 4525 | |1;ext.html;534.2493796216318;555.9381581179947;558.0596694569649;563.908836401563;598.4255115089513;39897;40877;40923.59076409235;40953;40982.38526422106;43890.341644875356;44634.33048504275;44676;44696;44732.3290150648;8679.349048821332;8849.159329863653;8867.822643547126;8882.733517994438;8887.066857979917;8918.509481978488;9089.363744537884;9115.407498512608;9119.772005699844;9126.178643922045;8908.198262156404;8951.641934322619;8976.371653984224;8980.730578082668;8985.415947963395;9098.68154614592;9137.131972462605;9165.999999999967;9218.400803947721;9231.169194772468;9104.954475227581;9223.76940576491;9270.536473176315;9277.907220927771;9293.72118836436;41238;41544.584554154375;41570.1685966282;41582.584174158175;41588.37617435741;3653.4702468141973;3732;3753.080495278647;3905.4141878718137;4204.705670603059;33013.339733205205;33037.6696233037;33071;34204.14489637754;35613;4125.566815484361;4139.130782535671;4225.873223803291;4229.407882896397;4233.809478573472;298743;301869;302788;303266.9999999978;303875;67060;67870.66064669644;68343.3165668337;68357;68393;72319;73626;73660.26339736534;73817.6309118451;73926.26073739301;17122.229499672543;17266.91366543159;17338.13309334528;17344.826551734575;17452.5636859077;12867.54963576289;12948.935255323662;12964.481420743254;12978.805317920238;13004.284764337863;18487.722684159748;18786.624267514846;18802.05989700537;18816;18875;6840.384365407137;6934.757283495053;6949.332160281496;6968.059311992816;7050.788476345718;999.4003597841237;1028.5217373921162;1030.4332617060586;1037.180627304436;1109.7059279290995;27664.861675691896;27691.446171076466;27864.16407507778;27939.720602793714;28052.85973570119;1062.436908438529;1174.747429302687;1211.715246916974;1234.882686144815;1246.4764798784531;14863.33115009827;14992.70014599702;15074.472393466176;15370.692586148438;15437.614059648598;329216;502712;519333;522622;527573;58720.41279587235;59317;59356.40643593509;59359.40640593539;59408;1397.76936805428;1400.1179257068186;1412.237391808412;1412.25150670145;1431.119861285302;29871.253218669706;30619.846900765355;30662.13516978182;32669.836650816593;32792.836035819666;51123;51377.229341559156;51487.48512514827;51778.964420710625;51827.74086129545;262539;263605;265156;265495;265782;35286.64713352936;35836.641633584375;35874.820625896704;48360.5163948356;48864.75567622139;46857.531424685316;46930.061398772516;47422.76288618535;47982.520174797806;48120;33822.49266261057;33953.9271174658;34541.30917381689;35036.12409689676;35373;34106.48840267348;34134.8293258542;34299.31401372008;34348.48477272893;34604;39181.804090980506;39965.20069598534;40017;40786.1842763149;41028.17943641051;36096.65037858646;36422.27155456929;36540.26919461649;36551.817240913624;36626;27628.723712762614;27889;28105.578416323362;28155;28396.85801570979 15:31:42 INFO - PROCESS | 4525 | |2;jquery.html;369.9445083237515;378.39834662886005;382.0791891541384;384.4463971880493;385.4584309045792;17835.28658853646;18784.15471303791;19776.604467910634;19790.901045494753;19836.702449463253;11794.410279486034;12034.759304813899;12077.396130193478;12157.635270941886;12260.693482662939;5026.346574945252;5063.6202284828605;5218.47815218477;5240.056789777838;5264.078786212417;5153.304303918979;5201.55786758126;5212;5216.035033518811;5255.684658920458;5079.74601269935;5176.715280659562;5203.739813009353;5207.817726379578;5262.973685131569;5170.250313704491;5193.506616871391;5218.086834803894;5250.238715386266;5261.631685781997;5054.595632349403;5067.822626208065;5076.923846142311;5078.111330517145;5126.92309615356;13137.27744974026;13288.069835111546;13301.600951971457;13304.933475332562;13315.40080696371;2409.6987876515436;2485.5898776702;2555.9105431309813;2953.9261518461994;3018.5170372740477;9630.18143457807;9822.607095716163;10012.349197302225;10126.645567405105;10223.744406389826;1820.3537744100786;1855.532807251187;1860.2744929477515;1905.1902941249914;1956.383739122172;48459.51540484585;59595.70202149005;60409;67859.66070169667;69198.3080169202;9887.703368898945;9996.600135994624;10258.230632702576;10339.689809305733;10467.644779924456;14432.278386080863;14476.34856431463;14487.348069336906;14488.710225795636;14498.85501144975;7872.409569282327;7978.5611791350875;8084.272415482635;8116.066652334939;8306.916930830736;7975.52146871178;8033.277005069455;8034.076081250614;8072.878906816402;8109.351251899834;4463.330500424897;4475.686701930834;4541.091781643684;4561.064981678748;4592.724436533818;1794.8115447877785;1836.8714190006572;1861.1066687989842;1891.101726679816;1919.932802351911;961.4663861556903;1012.3268026762267;1018.9337693049928;1034.715453250362;1037.3257382701304;17220.483385498454;17354.652906941792;17413.216405261795;17491.82508174902;18032.549186270448;1001.1740314240781;1018.8217062014267;1019.7807471393686;1054.0513537815873;1090.3022065877844;9857.457839818879;10197.898021019695;10211.234157438223;10296.382217067;10297.227707921937;461237;461519;462964;465537;468200;50493;76287.23712762912;79368;80443.59778201072;83010;1042.7080417482964;1044.6134930076073;1050.5115121468555;1056.5826498533036;1066.7546464313095;15489.5353139406;15510.612234693772;15549.533513994598;15781;15805.051696898223;33944;35422.291554169286;36171.457428139125;36221;36240.09399765027;47825.521744782105;47829.28256076092;50021.749891250314;50055.74972125116;50068.24897626466;8382.245597896219;8419.747407577783;8533.914660853312;8699.826003480022;8732.345074119594;12381.504739810667;13057.694230576866;13161.210327380388;13253.204807711569;13376.799348009594;11314.660560183207;11595;11614.303141811519;11785.116116291483;11830.349330786888;11585.768284634429;11962.10284228669;12089.57686480969;12206.877931220573;12208.389580521116;12031.819522706992;12057.51769929228;12261.14172007951;12277.69305767363;12386.75226495483;8660.696875609323;8681.739547813575;8682.479051256945;8746.30029597618;8748.081451447506;9162.725118246462;11525.82711259315;11631.941840290745;11666.650000499998;11783.410829458322 15:31:42 INFO - PROCESS | 4525 | |3;mootools.html;1540.3838464614157;1564.8513391227837;1729.3947118508524;1845.031358536769;1855.870089093764;7227.963860180705;8172.346212303017;8387.119352467995;8644.308455323575;8674.436161649504;8197.672093116269;8378.832423351529;8383.790405239872;8396.958015209932;8533.402661813676;2454.864982425966;2483.019207413071;2487.5522405966917;2498.113169824713;2498.1381423408893;2440.8779561021965;2487.6268559716095;2512.7110382306087;2518.0934863449143;2531.835430697008;2438.743931887153;2460.987695061531;2492.289697436231;2492.9252122436264;2505.5114252720728;2432.744561821001;2442.511497700467;2445.826003518321;2455.373879660684;2466.90132394704;2451.4729333193272;2467.247489515697;2481.5161043596504;2493.1897133431708;2501.2746303571944;8276.255137037635;8288.709895153701;8302;8325.292350150245;8326.2506374426;5322.494363035506;5379.488948549882;5396.082665946798;5398.78404863805;5412.891742165174;3389.6610338965907;3409.232922592422;3448.6551344865566;3480.5127282180515;3503.386907291214;1134.6610999021152;1163.1567113842482;1172.3727805624035;1181.2440038375446;1200.7598480303975;11901;11904.702382440335;12016.519339226421;12021.218620789621;12034.63896083119;4500.347449619787;4503.639708823286;4558.5897269245925;4563.977180114078;4605.585497305258;9513.809723805623;9521.952390238142;9531.142197202147;9534.427934323963;9537.332386732862;5214.504622060898;5218.165093585084;5222.712750798667;5253.212018197224;5269.130593452114;4131.35963925592;4664.95335046652;4701.294805779092;4758.262469317192;4778.259369797687;3806.6193380662266;3840.2895464339185;3841.2701586698995;3888.6694630956686;3889.8249578769023;1127.8533790607332;1141.0415251188874;1145.4043897173424;1147.053680713398;1181.031554125626;1337.505123104438;1338.4110991163857;1347.124369160054;1359.3882752761099;1360.0003997062151;7866.803329916798;7946.721864734822;8072.475289106307;8079.636416361278;8104.473209241499;1165.8717541070475;1168.67861338131;1191.6305945157028;1194.9761004779855;1204.8253003314646;5902.3507414184405;5923.526117910556;5926.199963005025;5952.7023648817385;5977.641341519523;10093.142082923034;10748.140148788078;10836.133109351233;10891.83662245067;10946.233763636468;10459.68620941373;10497.632582859564;10565.894341056644;10567.048965593134;10642.095421889226;8268.586570671443;8285.295749861329;8296.170382961776;8304.584770761438;8352.8329433411;7927.207279272026;7950.562719050507;7951.522908625501;8002.07976082758;8031.759047228593;9368.156865882103;9370.484623345781;9485.57314920844;9516.04839516043;9520.714378568655;9522.809543809224;9756.219502439646;9790.06994335537;9810;9834.360766550151;6235.314115447207;6835.213950395768;7050.929490705233;7150.284971502808;7284;8015.158408367038;8062.113167551447;8107.959460202661;8187.222213889671;8224.753257402288;7099.964500177466;7438.033055702724;7447.590382529013;7457.179710231979;7524.699012039676;7077.82305442368;7159.284071592799;7234.6020968847215;7308.488405811542;7363.668634911334;7562.924370756222;7564.621768911422;7596.734114305973;7604.619769011638;7645.273698998586;6932.757353492603;6983.406410455168;7002;7040.683169257498;7097.538659987084;7055.541389809646;7085.822854428474;7111.395531379891;7114.857702846018;7132.714691412285 15:31:42 INFO - PROCESS | 4525 | |4;prototype.html;343.0446207312634;349.90902365384994;351.5219301749618;352.6244549554724;355.1122194513714;6445.323241059691;6469.5147863910215;6494.740210391585;6529;6546.672666366687;6406.615603063819;6418.780431717982;6420.678966051691;6424.678766061702;6435.292117867031;4703.976480117594;4807.03859228154;4829.879253018667;4833.516648335173;4879.463259041511;4821.879453013686;4824.421069471651;4841.757912104398;4842.878928026792;4847.1517484440255;4768.165571025074;4784.473707892129;4793.472718001017;4811.398575178103;4824.011077729075;4800.49594792547;4800.90398192036;4803.831865884712;4822.927656085161;4827.08285425768;4174.248635245654;4174.248635245654;4178.12259425518;4184.811683474251;4188.371744238359;5972.163897054415;6068.635881847059;6077;6095.451409373178;6100.145979562864;5595.412481689405;5599.188117722948;5611.2144299798065;5612.915806262909;5616.354119276254;6718.529702920798;6746.460283177334;6750;6765.458763298924;6766.323367663194;4608.746518941457;4611.561901619374;4615.46922103959;4619.69971951822;4621.376114224604;7030.6484675766515;7061.540999834994;7098.3256590623805;7121.074260346122;7141.285871412869;4538.092381523708;4727.787249573777;4728.4562275338085;4738.976305118453;4740.19416699162;4733.95266047342;4758.904821903542;4760.547747963938;4762.404699412574;4768.690035147704;5558.221848941152;5573.972130139324;5580.91628625571;5590.91613625796;5592.468715472024;6859.622720750406;6861.210960739479;6862.382385585322;6863.382295593321;6870.45036397087;1654.2638525855878;1693.3395975569538;1699.0655139673377;1700.906450145254;1701.2854601067581;1060.1783617696192;1091.0889407344955;1094.6825420628088;1099.378850949211;1117.3184357541893;6524.706388212542;6525.706343214567;6559.6064236145985;6599.274079851212;6617.172853393326;7009.264027277062;7057.047298614724;7066.470014748915;7072.504924655224;7089.539179953286;6389.712462939179;6549.312322206099;6562.442192413603;6568.1789776277965;6582.934170658328;3857.286402015636;3898.3762597984755;3901.5318161820765;3905.511811023622;3910.061585219584;7263.455240856957;7349.63251837406;7370.926290737024;7371.152317483451;7377.077865266841;7312.305330993547;7339.743108991266;7341.926580734124;7366.263373662698;7367.557946523226;7135.429165666734;7322.707091716272;7363.300486453778;7365.189829118793;7370;7135.250798666066;7145.1068616422945;7151.749688760869;7168;7187.460940429384;6951.9304806953305;6955.686994085379;6993.160820701549;7006;7036.964815175891;7316.780496585111;7332.450066244946;7335.633218338955;7343.522671026366;7374.446916481393;4797.928031079607;4827.662063655511;4908.533689299511;4911.754412279443;4927.1131196384995;7109.60897150641;7149.82125446868;7153.35619794221;7155.713771449084;7196.640167991684;6879.071325371011;6911.930880691129;6947.3747362737595;6959.8608027838145;6963.40811031068;6889.689963951534;6951.9304806953305;6957.826054348682;6961.025456436204;6979.441644668516;6737.730490780314;6745.628990405575;6822.181338239443;6830.180378354629;6845.5550389224545;6960.965195173992;6979.825504362431;6981.057557229709;6988.685509152202;7002.439804815501;6796.218434879855;6810.216825064983;6816.727330906907;6820.317968203339;6823.147106611674 15:31:42 INFO - PROCESS | 4525 | |5;yui.html;801.1507801730166;812.1310198088045;839.6515446089873;841.5792103948025;856.6016802186982;13593.320333983298;13640.317984100804;13661.931690341558;13696.52062177824;13727.725445491109;12659;12663.176893501915;12717.30054846983;12815;12833.42249598768;751.8308380614372;852.7484392104344;887.6271965774358;888.7022847346115;896.3680605173337;883.1433509495811;895.4806212396827;899.1008991008991;899.1458114790942;899.2850683706437;961.711486554031;961.7691753979065;963.6627180486844;965.0060437749095;966.0387914025555;951.1487218939045;956.7273327101777;956.9043095690411;958.7171784323641;959.0649117110831;704.0917216790385;706.7067167125637;707.3174386716843;708.2917082917083;710.683745733149;13594;13656.385462654105;13668.863311366858;13669.316534173351;13683.452661893512;12374.938125309405;12597.74804503914;12718.618441446772;12753.426095825711;12863.035272354517;10643.946780266126;10816.72958176044;10912.672619821338;10938.398388088652;11236.157288203418;3834.65488106069;3853.8265778040054;3900.921981560353;3922.293987082324;3960.980195099006;51382.22926656103;52342;53882.73058634682;53884.73057634726;54144.45855541473;10164.440955747357;10230.386176829414;10285.43430111351;10293.74265643365;10364.06723394883;18489.5377615558;18521.814781852278;18615.162317695736;18623.255069797327;18661.533461663297;7686.692532298757;8168.591570421455;8318;8356.874646880302;8487.915120848837;4611.930821037688;4623.930641040387;4683.859484215479;4734.573888349996;4746.0745154694505;3318.2699806042633;3331.3503866746237;3360.9495857562156;3362.1090411041096;3366.7474939379154;668.7124536449373;669.10340144207;677.6137601567059;680.8365992161846;689.7999580121809;692.944564434844;695.2421860172335;701.7122979578348;707.4552594502204;728.8906664000336;8373.706920257884;8501.234888860032;8503.532305723245;8509.149085091565;8546;557.289455943667;690.1132045321738;702.2205352059312;703.8134894252925;706.1702499562992;3956.66368358687;4042.130941847458;4135.483064616923;4217.5782421758195;4279.593438623326;61168;63124;63185.68407158027;64731;64817;53535.732321338146;54055.72972135114;54228.18657720138;55116.9999999992;55234;49431;51387.22919156215;51631.225531617056;51849.740751296005;52198.47801521936;8778.166074222938;8924.598393072198;9135.40619859707;9159.358844880795;9510.286728495528;37199.628003720696;37986.43020354752;38166.618333817416;38369.2326153481;39462.210755785294;46886.53113468958;47035;47430.28854567115;48104.51895481;48275.75862120667;10814.621488247874;10868.891311086787;10920.18098642589;11030.944845275722;11115.388653623804;11876;12716.109872308849;12730.936345318585;12922.806157907828;12959.639237880265;11603.825942610698;11706.297622142698;11876.76246475083;11976.16166868311;12033.278003319829;11498.25261358009;11584.42077896085;11650.592229271935;11724.296542207494;11831.645050648494;11328.546858125583;11469.369184694588;11559.76880462403;11688.123390745557;11892.46483908209;10074.597016119566;10145.34055286404;10179.592816287266;10277.331973421704;10311.07200351972;10106.733825028236;10281.485925703835;10293.588256469657;10319;10350.689479315633 15:31:42 INFO - PROCESS | 4525 | __end_tp_report 15:31:42 INFO - PROCESS | 4525 | __start_cc_report 15:31:42 INFO - PROCESS | 4525 | _x_x_mozilla_cycle_collect,348 15:31:42 INFO - PROCESS | 4525 | __end_cc_report 15:31:42 INFO - PROCESS | 4525 | __startTimestamp1459981902195__endTimestamp 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | ------- Summary: start ------- 15:31:42 INFO - PROCESS | 4525 | Number of tests: 6 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#0] dojo.html Cycles:165 Average:5543.67 Median:5827.97 stddev:623.56 (10.7%) stddev-sans-first:599.37 15:31:42 INFO - PROCESS | 4525 | Values: 3267.8 3325.1 3332.7 3343.5 3359.2 5492.7 5511.0 5527.8 5528.8 5543.3 5509.2 5515.3 5516.3 5541.9 5550.2 5035.1 5066.8 5136.0 5144.1 5150.5 4958.7 5067.5 5109.1 5138.6 5160.9 5026.6 5036.5 5073.1 5101.7 5137.0 5134.4 5135.9 5138.7 5138.9 5151.0 4785.3 4874.0 5115.8 5131.6 5160.8 5348.7 5366.2 5376.2 5384.0 5385.2 5915.4 5954.4 5955.3 5969.1 5969.4 5995.8 6014.3 6067.5 6083.9 6089.7 5620.6 5637.0 5637.9 5644.3 5648.9 5841.0 6113.5 6126.0 6139.2 6147.2 5782.6 5842.9 5849.7 5851.9 5861.4 6006.4 6013.0 6018.6 6027.4 6029.2 5847.2 5877.6 5948.9 5959.3 5973.3 5927.6 5930.1 5930.5 5944.3 5970.8 4481.9 4503.4 4511.3 4514.3 4538.5 3990.4 4014.8 4043.0 4055.7 4057.9 5594.3 5630.5 5680.6 5688.2 5696.5 5990.7 5995.2 6017.7 6020.8 6056.2 5601.9 5679.9 5690.7 5695.6 5699.5 5118.8 5155.3 5169.1 5187.6 5208.2 6058.9 6077.6 6087.7 6093.0 6110.9 5810.2 5923.4 6005.9 6006.9 6008.1 5985.1 6094.9 6110.5 6114.5 6134.6 5930.2 5937.4 5939.3 5944.5 5953.2 5710.6 5953.6 6023.5 6036.5 6048.3 5842.4 5855.8 5858.2 5865.5 5882.2 5824.2 5841.0 5843.2 5847.9 5885.0 5625.8 5739.5 5745.9 5828.0 5847.7 5870.9 5927.9 5936.9 5950.7 5955.9 5854.4 5867.1 5868.7 5877.9 5878.5 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#1] ext.html Cycles:180 Average:53036.14 Median:40401.59 stddev:96371.72 (238.5%) stddev-sans-first:96561.44 15:31:42 INFO - PROCESS | 4525 | Values: 534.2 555.9 558.1 563.9 598.4 39897.0 40877.0 40923.6 40953.0 40982.4 43890.3 44634.3 44676.0 44696.0 44732.3 8679.3 8849.2 8867.8 8882.7 8887.1 8918.5 9089.4 9115.4 9119.8 9126.2 8908.2 8951.6 8976.4 8980.7 8985.4 9098.7 9137.1 9166.0 9218.4 9231.2 9105.0 9223.8 9270.5 9277.9 9293.7 41238.0 41544.6 41570.2 41582.6 41588.4 3653.5 3732.0 3753.1 3905.4 4204.7 33013.3 33037.7 33071.0 34204.1 35613.0 4125.6 4139.1 4225.9 4229.4 4233.8 298743.0 301869.0 302788.0 303267.0 303875.0 67060.0 67870.7 68343.3 68357.0 68393.0 72319.0 73626.0 73660.3 73817.6 73926.3 17122.2 17266.9 17338.1 17344.8 17452.6 12867.5 12948.9 12964.5 12978.8 13004.3 18487.7 18786.6 18802.1 18816.0 18875.0 6840.4 6934.8 6949.3 6968.1 7050.8 999.4 1028.5 1030.4 1037.2 1109.7 27664.9 27691.4 27864.2 27939.7 28052.9 1062.4 1174.7 1211.7 1234.9 1246.5 14863.3 14992.7 15074.5 15370.7 15437.6 329216.0 502712.0 519333.0 522622.0 527573.0 58720.4 59317.0 59356.4 59359.4 59408.0 1397.8 1400.1 1412.2 1412.3 1431.1 29871.3 30619.8 30662.1 32669.8 32792.8 51123.0 51377.2 51487.5 51779.0 51827.7 262539.0 263605.0 265156.0 265495.0 265782.0 35286.6 35836.6 35874.8 48360.5 48864.8 46857.5 46930.1 47422.8 47982.5 48120.0 33822.5 33953.9 34541.3 35036.1 35373.0 34106.5 34134.8 34299.3 34348.5 34604.0 39181.8 39965.2 40017.0 40786.2 41028.2 36096.7 36422.3 36540.3 36551.8 36626.0 27628.7 27889.0 28105.6 28155.0 28396.9 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#2] jquery.html Cycles:180 Average:26107.01 Median:2754.92 stddev:75981.29 (2758.0%) stddev-sans-first:76169.86 15:31:42 INFO - PROCESS | 4525 | Values: 369.9 378.4 382.1 384.4 385.5 17835.3 18784.2 19776.6 19790.9 19836.7 11794.4 12034.8 12077.4 12157.6 12260.7 5026.3 5063.6 5218.5 5240.1 5264.1 5153.3 5201.6 5212.0 5216.0 5255.7 5079.7 5176.7 5203.7 5207.8 5263.0 5170.3 5193.5 5218.1 5250.2 5261.6 5054.6 5067.8 5076.9 5078.1 5126.9 13137.3 13288.1 13301.6 13304.9 13315.4 2409.7 2485.6 2555.9 2953.9 3018.5 9630.2 9822.6 10012.3 10126.6 10223.7 1820.4 1855.5 1860.3 1905.2 1956.4 48459.5 59595.7 60409.0 67859.7 69198.3 9887.7 9996.6 10258.2 10339.7 10467.6 14432.3 14476.3 14487.3 14488.7 14498.9 7872.4 7978.6 8084.3 8116.1 8306.9 7975.5 8033.3 8034.1 8072.9 8109.4 4463.3 4475.7 4541.1 4561.1 4592.7 1794.8 1836.9 1861.1 1891.1 1919.9 961.5 1012.3 1018.9 1034.7 1037.3 17220.5 17354.7 17413.2 17491.8 18032.5 1001.2 1018.8 1019.8 1054.1 1090.3 9857.5 10197.9 10211.2 10296.4 10297.2 461237.0 461519.0 462964.0 465537.0 468200.0 50493.0 76287.2 79368.0 80443.6 83010.0 1042.7 1044.6 1050.5 1056.6 1066.8 15489.5 15510.6 15549.5 15781.0 15805.1 33944.0 35422.3 36171.5 36221.0 36240.1 47825.5 47829.3 50021.7 50055.7 50068.2 8382.2 8419.7 8533.9 8699.8 8732.3 12381.5 13057.7 13161.2 13253.2 13376.8 11314.7 11595.0 11614.3 11785.1 11830.3 11585.8 11962.1 12089.6 12206.9 12208.4 12031.8 12057.5 12261.1 12277.7 12386.8 8660.7 8681.7 8682.5 8746.3 8748.1 9162.7 11525.8 11631.9 11666.7 11783.4 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#3] mootools.html Cycles:180 Average:5957.02 Median:5350.99 stddev:3119.96 (58.3%) stddev-sans-first:3111.05 15:31:42 INFO - PROCESS | 4525 | Values: 1540.4 1564.9 1729.4 1845.0 1855.9 7228.0 8172.3 8387.1 8644.3 8674.4 8197.7 8378.8 8383.8 8397.0 8533.4 2454.9 2483.0 2487.6 2498.1 2498.1 2440.9 2487.6 2512.7 2518.1 2531.8 2438.7 2461.0 2492.3 2492.9 2505.5 2432.7 2442.5 2445.8 2455.4 2466.9 2451.5 2467.2 2481.5 2493.2 2501.3 8276.3 8288.7 8302.0 8325.3 8326.3 5322.5 5379.5 5396.1 5398.8 5412.9 3389.7 3409.2 3448.7 3480.5 3503.4 1134.7 1163.2 1172.4 1181.2 1200.8 11901.0 11904.7 12016.5 12021.2 12034.6 4500.3 4503.6 4558.6 4564.0 4605.6 9513.8 9522.0 9531.1 9534.4 9537.3 5214.5 5218.2 5222.7 5253.2 5269.1 4131.4 4665.0 4701.3 4758.3 4778.3 3806.6 3840.3 3841.3 3888.7 3889.8 1127.9 1141.0 1145.4 1147.1 1181.0 1337.5 1338.4 1347.1 1359.4 1360.0 7866.8 7946.7 8072.5 8079.6 8104.5 1165.9 1168.7 1191.6 1195.0 1204.8 5902.4 5923.5 5926.2 5952.7 5977.6 10093.1 10748.1 10836.1 10891.8 10946.2 10459.7 10497.6 10565.9 10567.0 10642.1 8268.6 8285.3 8296.2 8304.6 8352.8 7927.2 7950.6 7951.5 8002.1 8031.8 9368.2 9370.5 9485.6 9516.0 9520.7 9522.8 9756.2 9790.1 9810.0 9834.4 6235.3 6835.2 7050.9 7150.3 7284.0 8015.2 8062.1 8108.0 8187.2 8224.8 7100.0 7438.0 7447.6 7457.2 7524.7 7077.8 7159.3 7234.6 7308.5 7363.7 7562.9 7564.6 7596.7 7604.6 7645.3 6932.8 6983.4 7002.0 7040.7 7097.5 7055.5 7085.8 7111.4 7114.9 7132.7 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#4] prototype.html Cycles:180 Average:5709.55 Median:6527.35 stddev:1762.36 (27.0%) stddev-sans-first:1720.65 15:31:42 INFO - PROCESS | 4525 | Values: 343.0 349.9 351.5 352.6 355.1 6445.3 6469.5 6494.7 6529.0 6546.7 6406.6 6418.8 6420.7 6424.7 6435.3 4704.0 4807.0 4829.9 4833.5 4879.5 4821.9 4824.4 4841.8 4842.9 4847.2 4768.2 4784.5 4793.5 4811.4 4824.0 4800.5 4800.9 4803.8 4822.9 4827.1 4174.2 4174.2 4178.1 4184.8 4188.4 5972.2 6068.6 6077.0 6095.5 6100.1 5595.4 5599.2 5611.2 5612.9 5616.4 6718.5 6746.5 6750.0 6765.5 6766.3 4608.7 4611.6 4615.5 4619.7 4621.4 7030.6 7061.5 7098.3 7121.1 7141.3 4538.1 4727.8 4728.5 4739.0 4740.2 4734.0 4758.9 4760.5 4762.4 4768.7 5558.2 5574.0 5580.9 5590.9 5592.5 6859.6 6861.2 6862.4 6863.4 6870.5 1654.3 1693.3 1699.1 1700.9 1701.3 1060.2 1091.1 1094.7 1099.4 1117.3 6524.7 6525.7 6559.6 6599.3 6617.2 7009.3 7057.0 7066.5 7072.5 7089.5 6389.7 6549.3 6562.4 6568.2 6582.9 3857.3 3898.4 3901.5 3905.5 3910.1 7263.5 7349.6 7370.9 7371.2 7377.1 7312.3 7339.7 7341.9 7366.3 7367.6 7135.4 7322.7 7363.3 7365.2 7370.0 7135.3 7145.1 7151.7 7168.0 7187.5 6951.9 6955.7 6993.2 7006.0 7037.0 7316.8 7332.5 7335.6 7343.5 7374.4 4797.9 4827.7 4908.5 4911.8 4927.1 7109.6 7149.8 7153.4 7155.7 7196.6 6879.1 6911.9 6947.4 6959.9 6963.4 6889.7 6951.9 6957.8 6961.0 6979.4 6737.7 6745.6 6822.2 6830.2 6845.6 6961.0 6979.8 6981.1 6988.7 7002.4 6796.2 6810.2 6816.7 6820.3 6823.1 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - PROCESS | 4525 | [#5] yui.html Cycles:180 Average:14688.15 Median:4617.93 stddev:17415.01 (377.1%) stddev-sans-first:17432.64 15:31:42 INFO - PROCESS | 4525 | Values: 801.2 812.1 839.7 841.6 856.6 13593.3 13640.3 13661.9 13696.5 13727.7 12659.0 12663.2 12717.3 12815.0 12833.4 751.8 852.7 887.6 888.7 896.4 883.1 895.5 899.1 899.1 899.3 961.7 961.8 963.7 965.0 966.0 951.1 956.7 956.9 958.7 959.1 704.1 706.7 707.3 708.3 710.7 13594.0 13656.4 13668.9 13669.3 13683.5 12374.9 12597.7 12718.6 12753.4 12863.0 10643.9 10816.7 10912.7 10938.4 11236.2 3834.7 3853.8 3900.9 3922.3 3961.0 51382.2 52342.0 53882.7 53884.7 54144.5 10164.4 10230.4 10285.4 10293.7 10364.1 18489.5 18521.8 18615.2 18623.3 18661.5 7686.7 8168.6 8318.0 8356.9 8487.9 4611.9 4623.9 4683.9 4734.6 4746.1 3318.3 3331.4 3360.9 3362.1 3366.7 668.7 669.1 677.6 680.8 689.8 692.9 695.2 701.7 707.5 728.9 8373.7 8501.2 8503.5 8509.1 8546.0 557.3 690.1 702.2 703.8 706.2 3956.7 4042.1 4135.5 4217.6 4279.6 61168.0 63124.0 63185.7 64731.0 64817.0 53535.7 54055.7 54228.2 55117.0 55234.0 49431.0 51387.2 51631.2 51849.7 52198.5 8778.2 8924.6 9135.4 9159.4 9510.3 37199.6 37986.4 38166.6 38369.2 39462.2 46886.5 47035.0 47430.3 48104.5 48275.8 10814.6 10868.9 10920.2 11030.9 11115.4 11876.0 12716.1 12730.9 12922.8 12959.6 11603.8 11706.3 11876.8 11976.2 12033.3 11498.3 11584.4 11650.6 11724.3 11831.6 11328.5 11469.4 11559.8 11688.1 11892.5 10074.6 10145.3 10179.6 10277.3 10311.1 10106.7 10281.5 10293.6 10319.0 10350.7 15:31:42 INFO - PROCESS | 4525 | -------- Summary: end -------- 15:31:42 INFO - PROCESS | 4525 | 15:31:42 INFO - TEST-INFO | 4525: exit 0 15:31:42 INFO - TEST-OK | dromaeo_css | took 1109394ms 15:31:42 INFO - TEST-START | kraken 15:31:42 INFO - operating with platform_type : linux_ 15:31:42 INFO - Initialising browser for kraken test... 15:31:42 INFO - TEST-INFO | started process 4769 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgYrzpW/profile http://localhost:51513/getInfo.html) 15:31:46 INFO - PROCESS | 4769 | 15:31:46 INFO - PROCESS | 4769 | (process:4843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:31:47 INFO - PROCESS | 4769 | __metrics Screen width/height:1600/1200 15:31:47 INFO - PROCESS | 4769 | colorDepth:24 15:31:47 INFO - PROCESS | 4769 | Browser inner width/height: 1024/697 15:31:47 INFO - PROCESS | 4769 | __metrics 15:31:47 ERROR - PROCESS | 4769 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:31:48 INFO - TEST-INFO | 4769: exit 0 15:31:48 INFO - Browser initialized. 15:31:48 INFO - Running cycle 1/1 for kraken test... 15:31:48 INFO - TEST-INFO | started process 4894 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgYrzpW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:50 INFO - PROCESS | 4894 | 15:31:50 INFO - PROCESS | 4894 | (process:4963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:00 INFO - PROCESS | 4894 | RSS: Main: 151425024 15:32:00 INFO - PROCESS | 4894 | 15:32:03 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51513/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:03 INFO - PROCESS | 4894 | RSS: Main: 155381760 15:32:03 INFO - PROCESS | 4894 | 15:32:06 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51513/tests/kraken/driver.html?testName=audio-dft) 15:32:06 INFO - PROCESS | 4894 | RSS: Main: 155447296 15:32:06 INFO - PROCESS | 4894 | 15:32:09 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51513/tests/kraken/driver.html?testName=audio-fft) 15:32:10 INFO - PROCESS | 4894 | RSS: Main: 156291072 15:32:10 INFO - PROCESS | 4894 | 15:32:12 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51513/tests/kraken/driver.html?testName=audio-oscillator) 15:32:13 INFO - PROCESS | 4894 | RSS: Main: 155684864 15:32:13 INFO - PROCESS | 4894 | 15:32:15 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:15 INFO - PROCESS | 4894 | RSS: Main: 156512256 15:32:15 INFO - PROCESS | 4894 | 15:32:19 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51513/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:19 INFO - PROCESS | 4894 | RSS: Main: 156045312 15:32:19 INFO - PROCESS | 4894 | 15:32:22 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51513/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:23 INFO - PROCESS | 4894 | RSS: Main: 156487680 15:32:23 INFO - PROCESS | 4894 | 15:32:26 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51513/tests/kraken/driver.html?testName=json-parse-financial) 15:32:27 INFO - PROCESS | 4894 | RSS: Main: 155955200 15:32:27 INFO - PROCESS | 4894 | 15:32:28 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:29 INFO - PROCESS | 4894 | RSS: Main: 156307456 15:32:29 INFO - PROCESS | 4894 | 15:32:30 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:31 INFO - PROCESS | 4894 | RSS: Main: 155668480 15:32:31 INFO - PROCESS | 4894 | 15:32:33 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:34 INFO - PROCESS | 4894 | RSS: Main: 156364800 15:32:34 INFO - PROCESS | 4894 | 15:32:36 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:37 INFO - PROCESS | 4894 | RSS: Main: 156413952 15:32:37 INFO - PROCESS | 4894 | 15:32:39 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:40 INFO - PROCESS | 4894 | RSS: Main: 156942336 15:32:40 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | Cycle 1(1): loaded http://localhost:51513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51513/tests/kraken/driver.html?testName=ai-astar) 15:32:42 INFO - PROCESS | 4894 | RSS: Main: 158482432 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | __start_tp_report 15:32:42 INFO - PROCESS | 4894 | _x_x_mozilla_page_load 15:32:42 INFO - PROCESS | 4894 | _x_x_mozilla_page_load_details 15:32:42 INFO - PROCESS | 4894 | |i|pagename|runs| 15:32:42 INFO - PROCESS | 4894 | |0;ai-astar;112;105;111;110;114;122;110;118;111;110 15:32:42 INFO - PROCESS | 4894 | |1;audio-beat-detection;154;125;158;167;131;151;168;128;172;128 15:32:42 INFO - PROCESS | 4894 | |2;audio-dft;163;163;161;162;162;160;163;164;167;163 15:32:42 INFO - PROCESS | 4894 | |3;audio-fft;74;76;75;164;76;75;76;73;163;76 15:32:42 INFO - PROCESS | 4894 | |4;audio-oscillator;93;93;147;93;93;94;141;94;93;140 15:32:42 INFO - PROCESS | 4894 | |5;imaging-gaussian-blur;118;117;118;119;117;117;117;118;117;117 15:32:42 INFO - PROCESS | 4894 | |6;imaging-darkroom;146;146;147;148;147;146;147;146;147;148 15:32:42 INFO - PROCESS | 4894 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 15:32:42 INFO - PROCESS | 4894 | |8;json-parse-financial;55;58;54;60;55;58;56;64;55;57 15:32:42 INFO - PROCESS | 4894 | |9;json-stringify-tinderbox;64;64;64;65;65;64;68;65;69;65 15:32:42 INFO - PROCESS | 4894 | |10;stanford-crypto-aes;79;85;88;80;80;79;91;78;79;79 15:32:42 INFO - PROCESS | 4894 | |11;stanford-crypto-ccm;118;120;120;134;112;114;115;113;124;115 15:32:42 INFO - PROCESS | 4894 | |12;stanford-crypto-pbkdf2;138;146;145;145;145;136;147;144;150;145 15:32:42 INFO - PROCESS | 4894 | |13;stanford-crypto-sha256-iterative;69;67;71;67;74;67;70;68;69;67 15:32:42 INFO - PROCESS | 4894 | __end_tp_report 15:32:42 INFO - PROCESS | 4894 | __start_cc_report 15:32:42 INFO - PROCESS | 4894 | _x_x_mozilla_cycle_collect,845 15:32:42 INFO - PROCESS | 4894 | __end_cc_report 15:32:42 INFO - PROCESS | 4894 | __startTimestamp1459981962265__endTimestamp 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | ------- Summary: start ------- 15:32:42 INFO - PROCESS | 4894 | Number of tests: 14 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.50 stddev:4.74 (4.2%) stddev-sans-first:5.02 15:32:42 INFO - PROCESS | 4894 | Values: 112.0 105.0 111.0 110.0 114.0 122.0 110.0 118.0 111.0 110.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:156.00 stddev:18.56 (11.9%) stddev-sans-first:19.56 15:32:42 INFO - PROCESS | 4894 | Values: 154.0 125.0 158.0 167.0 131.0 151.0 168.0 128.0 172.0 128.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 15:32:42 INFO - PROCESS | 4894 | Values: 163.0 163.0 161.0 162.0 162.0 160.0 163.0 164.0 167.0 163.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:37.28 (49.4%) stddev-sans-first:38.91 15:32:42 INFO - PROCESS | 4894 | Values: 74.0 76.0 75.0 164.0 76.0 75.0 76.0 73.0 163.0 76.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:23.92 (25.7%) stddev-sans-first:24.74 15:32:42 INFO - PROCESS | 4894 | Values: 93.0 93.0 147.0 93.0 93.0 94.0 141.0 94.0 93.0 140.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:32:42 INFO - PROCESS | 4894 | Values: 118.0 117.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 117.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 15:32:42 INFO - PROCESS | 4894 | Values: 146.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 148.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 15:32:42 INFO - PROCESS | 4894 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:3.01 (5.2%) stddev-sans-first:3.09 15:32:42 INFO - PROCESS | 4894 | Values: 55.0 58.0 54.0 60.0 55.0 58.0 56.0 64.0 55.0 57.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.81 15:32:42 INFO - PROCESS | 4894 | Values: 64.0 64.0 64.0 65.0 65.0 64.0 68.0 65.0 69.0 65.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.00 stddev:4.54 (5.7%) stddev-sans-first:4.70 15:32:42 INFO - PROCESS | 4894 | Values: 79.0 85.0 88.0 80.0 80.0 79.0 91.0 78.0 79.0 79.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:119.00 stddev:6.60 (5.5%) stddev-sans-first:7.00 15:32:42 INFO - PROCESS | 4894 | Values: 118.0 120.0 120.0 134.0 112.0 114.0 115.0 113.0 124.0 115.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:145.00 stddev:4.12 (2.8%) stddev-sans-first:3.73 15:32:42 INFO - PROCESS | 4894 | Values: 138.0 146.0 145.0 145.0 145.0 136.0 147.0 144.0 150.0 145.0 15:32:42 INFO - PROCESS | 4894 | 15:32:42 INFO - PROCESS | 4894 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.28 (3.3%) stddev-sans-first:2.42 15:32:42 INFO - PROCESS | 4894 | Values: 69.0 67.0 71.0 67.0 74.0 67.0 70.0 68.0 69.0 67.0 15:32:42 INFO - PROCESS | 4894 | -------- Summary: end -------- 15:32:42 INFO - PROCESS | 4894 | 15:32:43 INFO - TEST-INFO | 4894: exit 0 15:32:43 INFO - TEST-OK | kraken | took 60327ms 15:32:43 INFO - SUITE-END | took 1169s 15:32:43 INFO - Completed test suite (00:19:29) 15:32:43 INFO - javascript benchmark 15:32:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3267.7875938064026, 3325.102222399951, 3332.716719078878, 3343.465045592706, 3359.1770016346, 5492.697901615415, 5511.0, 5527.751251193696, 5528.75120619572, 5543.279373681421, 5509.228707980886, 5515.338159420865, 5516.255305533752, 5541.944580554194, 5550.16747487877, 5035.068512325213, 5066.822661206858, 5136.0, 5144.09978253806, 5150.459201783815, 4958.652894297401, 5067.467915868836, 5109.054824857395, 5138.5889128869785, 5160.92258616121, 5026.597872170218, 5036.546710796028, 5073.112205364065, 5101.6683915545555, 5137.0, 5134.4095429025765, 5135.897282054357, 5138.665986710852, 5138.922916156261, 5150.97424512875, 4785.3300537924715, 4874.049560335736, 5115.769790359443, 5131.640785145041, 5160.8193713220235, 5348.652337598043, 5366.195070739382, 5376.166694162411, 5384.0, 5385.246065550826, 5915.408459154093, 5954.374790646963, 5955.255593050869, 5969.134475501028, 5969.373215812364, 5995.7901473448655, 6014.338422773491, 6067.544934129958, 6083.878322433527, 6089.695515224265, 5620.634658747168, 5637.041702910515, 5637.943620563783, 5644.266245388114, 5648.943510564924, 5840.970795145997, 6113.480354169946, 6126.0, 6139.171211886427, 6147.200863887666, 5782.566307526952, 5842.941570584325, 5849.736761845727, 5851.941480585225, 5861.384554621789, 6006.369331220247, 6013.037913933749, 6018.578699490994, 6027.397260273938, 6029.155918171459, 5847.152162936351, 5877.617954832922, 5948.940510594925, 5959.344472108065, 5973.342932277446, 5927.614705044159, 5930.05119180929, 5930.466258036798, 5944.256967879015, 5970.820875373659, 4481.932771008437, 4503.369528266046, 4511.323301504801, 4514.255147900625, 4538.52345503724, 3990.4014397840556, 4014.7992600369867, 4043.0498832774274, 4055.6958228133008, 4057.9391309130388, 5594.328680558359, 5630.465105814941, 5680.573956953162, 5688.23208866806, 5696.544276457874, 5990.73041713124, 5995.190649262381, 6017.669028203491, 6020.849478763066, 6056.212692350055, 5601.887962240814, 5679.886402271932, 5690.715464226772, 5695.572832037614, 5699.458551437607, 5118.795248190105, 5155.329807125125, 5169.121249387613, 5187.636865419385, 5208.218767184952, 6058.90911636317, 6077.604955677867, 6087.726052327655, 6093.0, 6110.908336374958, 5810.157527158453, 5923.378045305181, 6005.90991135142, 6006.909896351471, 6008.128821320972, 5985.132155837467, 6094.908576371269, 6110.51115910735, 6114.540688159306, 6134.631922084689, 5930.229070220844, 5937.435943585352, 5939.316978547522, 5944.494717949023, 5953.166556681981, 5710.600257981901, 5953.6427814329545, 6023.518118550418, 6036.456718895145, 6048.274207095177, 5842.444967728059, 5855.824325270249, 5858.209141765978, 5865.472107510344, 5882.23530940975, 5824.242848429677, 5841.036229022334, 5843.181954526454, 5847.8538036547725, 5884.970130227279, 5625.803096891589, 5739.512141468022, 5745.885082298414, 5827.970860145672, 5847.678377689268, 5870.9432302184305, 5927.940720592911, 5936.910946335895, 5950.702464876826, 5955.851103722268, 5854.414558544111, 5867.149263356875, 5868.67722275279, 5877.882442351043, 5878.529717622666], "unit": "score", "name": "dojo.html", "value": 5502.427440782252}, {"lowerIsBetter": false, "replicates": [534.2493796216318, 555.9381581179947, 558.0596694569649, 563.908836401563, 598.4255115089513, 39897.0, 40877.0, 40923.59076409235, 40953.0, 40982.38526422106, 43890.341644875356, 44634.33048504275, 44676.0, 44696.0, 44732.3290150648, 8679.349048821332, 8849.159329863653, 8867.822643547126, 8882.733517994438, 8887.066857979917, 8918.509481978488, 9089.363744537884, 9115.407498512608, 9119.772005699844, 9126.178643922045, 8908.198262156404, 8951.641934322619, 8976.371653984224, 8980.730578082668, 8985.415947963395, 9098.68154614592, 9137.131972462605, 9165.999999999967, 9218.400803947721, 9231.169194772468, 9104.954475227581, 9223.76940576491, 9270.536473176315, 9277.907220927771, 9293.72118836436, 41238.0, 41544.584554154375, 41570.1685966282, 41582.584174158175, 41588.37617435741, 3653.4702468141973, 3732.0, 3753.080495278647, 3905.4141878718137, 4204.705670603059, 33013.339733205205, 33037.6696233037, 33071.0, 34204.14489637754, 35613.0, 4125.566815484361, 4139.130782535671, 4225.873223803291, 4229.407882896397, 4233.809478573472, 298743.0, 301869.0, 302788.0, 303266.9999999978, 303875.0, 67060.0, 67870.66064669644, 68343.3165668337, 68357.0, 68393.0, 72319.0, 73626.0, 73660.26339736534, 73817.6309118451, 73926.26073739301, 17122.229499672543, 17266.91366543159, 17338.13309334528, 17344.826551734575, 17452.5636859077, 12867.54963576289, 12948.935255323662, 12964.481420743254, 12978.805317920238, 13004.284764337863, 18487.722684159748, 18786.624267514846, 18802.05989700537, 18816.0, 18875.0, 6840.384365407137, 6934.757283495053, 6949.332160281496, 6968.059311992816, 7050.788476345718, 999.4003597841237, 1028.5217373921162, 1030.4332617060586, 1037.180627304436, 1109.7059279290995, 27664.861675691896, 27691.446171076466, 27864.16407507778, 27939.720602793714, 28052.85973570119, 1062.436908438529, 1174.747429302687, 1211.715246916974, 1234.882686144815, 1246.4764798784531, 14863.33115009827, 14992.70014599702, 15074.472393466176, 15370.692586148438, 15437.614059648598, 329216.0, 502712.0, 519333.0, 522622.0, 527573.0, 58720.41279587235, 59317.0, 59356.40643593509, 59359.40640593539, 59408.0, 1397.76936805428, 1400.1179257068186, 1412.237391808412, 1412.25150670145, 1431.119861285302, 29871.253218669706, 30619.846900765355, 30662.13516978182, 32669.836650816593, 32792.836035819666, 51123.0, 51377.229341559156, 51487.48512514827, 51778.964420710625, 51827.74086129545, 262539.0, 263605.0, 265156.0, 265495.0, 265782.0, 35286.64713352936, 35836.641633584375, 35874.820625896704, 48360.5163948356, 48864.75567622139, 46857.531424685316, 46930.061398772516, 47422.76288618535, 47982.520174797806, 48120.0, 33822.49266261057, 33953.9271174658, 34541.30917381689, 35036.12409689676, 35373.0, 34106.48840267348, 34134.8293258542, 34299.31401372008, 34348.48477272893, 34604.0, 39181.804090980506, 39965.20069598534, 40017.0, 40786.1842763149, 41028.17943641051, 36096.65037858646, 36422.27155456929, 36540.26919461649, 36551.817240913624, 36626.0, 27628.723712762614, 27889.0, 28105.578416323362, 28155.0, 28396.85801570979], "unit": "score", "name": "ext.html", "value": 19848.573335495283}, {"lowerIsBetter": false, "replicates": [369.9445083237515, 378.39834662886005, 382.0791891541384, 384.4463971880493, 385.4584309045792, 17835.28658853646, 18784.15471303791, 19776.604467910634, 19790.901045494753, 19836.702449463253, 11794.410279486034, 12034.759304813899, 12077.396130193478, 12157.635270941886, 12260.693482662939, 5026.346574945252, 5063.6202284828605, 5218.47815218477, 5240.056789777838, 5264.078786212417, 5153.304303918979, 5201.55786758126, 5212.0, 5216.035033518811, 5255.684658920458, 5079.74601269935, 5176.715280659562, 5203.739813009353, 5207.817726379578, 5262.973685131569, 5170.250313704491, 5193.506616871391, 5218.086834803894, 5250.238715386266, 5261.631685781997, 5054.595632349403, 5067.822626208065, 5076.923846142311, 5078.111330517145, 5126.92309615356, 13137.27744974026, 13288.069835111546, 13301.600951971457, 13304.933475332562, 13315.40080696371, 2409.6987876515436, 2485.5898776702, 2555.9105431309813, 2953.9261518461994, 3018.5170372740477, 9630.18143457807, 9822.607095716163, 10012.349197302225, 10126.645567405105, 10223.744406389826, 1820.3537744100786, 1855.532807251187, 1860.2744929477515, 1905.1902941249914, 1956.383739122172, 48459.51540484585, 59595.70202149005, 60409.0, 67859.66070169667, 69198.3080169202, 9887.703368898945, 9996.600135994624, 10258.230632702576, 10339.689809305733, 10467.644779924456, 14432.278386080863, 14476.34856431463, 14487.348069336906, 14488.710225795636, 14498.85501144975, 7872.409569282327, 7978.5611791350875, 8084.272415482635, 8116.066652334939, 8306.916930830736, 7975.52146871178, 8033.277005069455, 8034.076081250614, 8072.878906816402, 8109.351251899834, 4463.330500424897, 4475.686701930834, 4541.091781643684, 4561.064981678748, 4592.724436533818, 1794.8115447877785, 1836.8714190006572, 1861.1066687989842, 1891.101726679816, 1919.932802351911, 961.4663861556903, 1012.3268026762267, 1018.9337693049928, 1034.715453250362, 1037.3257382701304, 17220.483385498454, 17354.652906941792, 17413.216405261795, 17491.82508174902, 18032.549186270448, 1001.1740314240781, 1018.8217062014267, 1019.7807471393686, 1054.0513537815873, 1090.3022065877844, 9857.457839818879, 10197.898021019695, 10211.234157438223, 10296.382217067, 10297.227707921937, 461237.0, 461519.0, 462964.0, 465537.0, 468200.0, 50493.0, 76287.23712762912, 79368.0, 80443.59778201072, 83010.0, 1042.7080417482964, 1044.6134930076073, 1050.5115121468555, 1056.5826498533036, 1066.7546464313095, 15489.5353139406, 15510.612234693772, 15549.533513994598, 15781.0, 15805.051696898223, 33944.0, 35422.291554169286, 36171.457428139125, 36221.0, 36240.09399765027, 47825.521744782105, 47829.28256076092, 50021.749891250314, 50055.74972125116, 50068.24897626466, 8382.245597896219, 8419.747407577783, 8533.914660853312, 8699.826003480022, 8732.345074119594, 12381.504739810667, 13057.694230576866, 13161.210327380388, 13253.204807711569, 13376.799348009594, 11314.660560183207, 11595.0, 11614.303141811519, 11785.116116291483, 11830.349330786888, 11585.768284634429, 11962.10284228669, 12089.57686480969, 12206.877931220573, 12208.389580521116, 12031.819522706992, 12057.51769929228, 12261.14172007951, 12277.69305767363, 12386.75226495483, 8660.696875609323, 8681.739547813575, 8682.479051256945, 8746.30029597618, 8748.081451447506, 9162.725118246462, 11525.82711259315, 11631.941840290745, 11666.650000499998, 11783.410829458322], "unit": "score", "name": "jquery.html", "value": 8557.522301441208}, {"lowerIsBetter": false, "replicates": [1540.3838464614157, 1564.8513391227837, 1729.3947118508524, 1845.031358536769, 1855.870089093764, 7227.963860180705, 8172.346212303017, 8387.119352467995, 8644.308455323575, 8674.436161649504, 8197.672093116269, 8378.832423351529, 8383.790405239872, 8396.958015209932, 8533.402661813676, 2454.864982425966, 2483.019207413071, 2487.5522405966917, 2498.113169824713, 2498.1381423408893, 2440.8779561021965, 2487.6268559716095, 2512.7110382306087, 2518.0934863449143, 2531.835430697008, 2438.743931887153, 2460.987695061531, 2492.289697436231, 2492.9252122436264, 2505.5114252720728, 2432.744561821001, 2442.511497700467, 2445.826003518321, 2455.373879660684, 2466.90132394704, 2451.4729333193272, 2467.247489515697, 2481.5161043596504, 2493.1897133431708, 2501.2746303571944, 8276.255137037635, 8288.709895153701, 8302.0, 8325.292350150245, 8326.2506374426, 5322.494363035506, 5379.488948549882, 5396.082665946798, 5398.78404863805, 5412.891742165174, 3389.6610338965907, 3409.232922592422, 3448.6551344865566, 3480.5127282180515, 3503.386907291214, 1134.6610999021152, 1163.1567113842482, 1172.3727805624035, 1181.2440038375446, 1200.7598480303975, 11901.0, 11904.702382440335, 12016.519339226421, 12021.218620789621, 12034.63896083119, 4500.347449619787, 4503.639708823286, 4558.5897269245925, 4563.977180114078, 4605.585497305258, 9513.809723805623, 9521.952390238142, 9531.142197202147, 9534.427934323963, 9537.332386732862, 5214.504622060898, 5218.165093585084, 5222.712750798667, 5253.212018197224, 5269.130593452114, 4131.35963925592, 4664.95335046652, 4701.294805779092, 4758.262469317192, 4778.259369797687, 3806.6193380662266, 3840.2895464339185, 3841.2701586698995, 3888.6694630956686, 3889.8249578769023, 1127.8533790607332, 1141.0415251188874, 1145.4043897173424, 1147.053680713398, 1181.031554125626, 1337.505123104438, 1338.4110991163857, 1347.124369160054, 1359.3882752761099, 1360.0003997062151, 7866.803329916798, 7946.721864734822, 8072.475289106307, 8079.636416361278, 8104.473209241499, 1165.8717541070475, 1168.67861338131, 1191.6305945157028, 1194.9761004779855, 1204.8253003314646, 5902.3507414184405, 5923.526117910556, 5926.199963005025, 5952.7023648817385, 5977.641341519523, 10093.142082923034, 10748.140148788078, 10836.133109351233, 10891.83662245067, 10946.233763636468, 10459.68620941373, 10497.632582859564, 10565.894341056644, 10567.048965593134, 10642.095421889226, 8268.586570671443, 8285.295749861329, 8296.170382961776, 8304.584770761438, 8352.8329433411, 7927.207279272026, 7950.562719050507, 7951.522908625501, 8002.07976082758, 8031.759047228593, 9368.156865882103, 9370.484623345781, 9485.57314920844, 9516.04839516043, 9520.714378568655, 9522.809543809224, 9756.219502439646, 9790.06994335537, 9810.0, 9834.360766550151, 6235.314115447207, 6835.213950395768, 7050.929490705233, 7150.284971502808, 7284.0, 8015.158408367038, 8062.113167551447, 8107.959460202661, 8187.222213889671, 8224.753257402288, 7099.964500177466, 7438.033055702724, 7447.590382529013, 7457.179710231979, 7524.699012039676, 7077.82305442368, 7159.284071592799, 7234.6020968847215, 7308.488405811542, 7363.668634911334, 7562.924370756222, 7564.621768911422, 7596.734114305973, 7604.619769011638, 7645.273698998586, 6932.757353492603, 6983.406410455168, 7002.0, 7040.683169257498, 7097.538659987084, 7055.541389809646, 7085.822854428474, 7111.395531379891, 7114.857702846018, 7132.714691412285], "unit": "score", "name": "mootools.html", "value": 4889.615046587116}, {"lowerIsBetter": false, "replicates": [343.0446207312634, 349.90902365384994, 351.5219301749618, 352.6244549554724, 355.1122194513714, 6445.323241059691, 6469.5147863910215, 6494.740210391585, 6529.0, 6546.672666366687, 6406.615603063819, 6418.780431717982, 6420.678966051691, 6424.678766061702, 6435.292117867031, 4703.976480117594, 4807.03859228154, 4829.879253018667, 4833.516648335173, 4879.463259041511, 4821.879453013686, 4824.421069471651, 4841.757912104398, 4842.878928026792, 4847.1517484440255, 4768.165571025074, 4784.473707892129, 4793.472718001017, 4811.398575178103, 4824.011077729075, 4800.49594792547, 4800.90398192036, 4803.831865884712, 4822.927656085161, 4827.08285425768, 4174.248635245654, 4174.248635245654, 4178.12259425518, 4184.811683474251, 4188.371744238359, 5972.163897054415, 6068.635881847059, 6077.0, 6095.451409373178, 6100.145979562864, 5595.412481689405, 5599.188117722948, 5611.2144299798065, 5612.915806262909, 5616.354119276254, 6718.529702920798, 6746.460283177334, 6750.0, 6765.458763298924, 6766.323367663194, 4608.746518941457, 4611.561901619374, 4615.46922103959, 4619.69971951822, 4621.376114224604, 7030.6484675766515, 7061.540999834994, 7098.3256590623805, 7121.074260346122, 7141.285871412869, 4538.092381523708, 4727.787249573777, 4728.4562275338085, 4738.976305118453, 4740.19416699162, 4733.95266047342, 4758.904821903542, 4760.547747963938, 4762.404699412574, 4768.690035147704, 5558.221848941152, 5573.972130139324, 5580.91628625571, 5590.91613625796, 5592.468715472024, 6859.622720750406, 6861.210960739479, 6862.382385585322, 6863.382295593321, 6870.45036397087, 1654.2638525855878, 1693.3395975569538, 1699.0655139673377, 1700.906450145254, 1701.2854601067581, 1060.1783617696192, 1091.0889407344955, 1094.6825420628088, 1099.378850949211, 1117.3184357541893, 6524.706388212542, 6525.706343214567, 6559.6064236145985, 6599.274079851212, 6617.172853393326, 7009.264027277062, 7057.047298614724, 7066.470014748915, 7072.504924655224, 7089.539179953286, 6389.712462939179, 6549.312322206099, 6562.442192413603, 6568.1789776277965, 6582.934170658328, 3857.286402015636, 3898.3762597984755, 3901.5318161820765, 3905.511811023622, 3910.061585219584, 7263.455240856957, 7349.63251837406, 7370.926290737024, 7371.152317483451, 7377.077865266841, 7312.305330993547, 7339.743108991266, 7341.926580734124, 7366.263373662698, 7367.557946523226, 7135.429165666734, 7322.707091716272, 7363.300486453778, 7365.189829118793, 7370.0, 7135.250798666066, 7145.1068616422945, 7151.749688760869, 7168.0, 7187.460940429384, 6951.9304806953305, 6955.686994085379, 6993.160820701549, 7006.0, 7036.964815175891, 7316.780496585111, 7332.450066244946, 7335.633218338955, 7343.522671026366, 7374.446916481393, 4797.928031079607, 4827.662063655511, 4908.533689299511, 4911.754412279443, 4927.1131196384995, 7109.60897150641, 7149.82125446868, 7153.35619794221, 7155.713771449084, 7196.640167991684, 6879.071325371011, 6911.930880691129, 6947.3747362737595, 6959.8608027838145, 6963.40811031068, 6889.689963951534, 6951.9304806953305, 6957.826054348682, 6961.025456436204, 6979.441644668516, 6737.730490780314, 6745.628990405575, 6822.181338239443, 6830.180378354629, 6845.5550389224545, 6960.965195173992, 6979.825504362431, 6981.057557229709, 6988.685509152202, 7002.439804815501, 6796.218434879855, 6810.216825064983, 6816.727330906907, 6820.317968203339, 6823.147106611674], "unit": "score", "name": "prototype.html", "value": 5128.04422292067}, {"lowerIsBetter": false, "replicates": [801.1507801730166, 812.1310198088045, 839.6515446089873, 841.5792103948025, 856.6016802186982, 13593.320333983298, 13640.317984100804, 13661.931690341558, 13696.52062177824, 13727.725445491109, 12659.0, 12663.176893501915, 12717.30054846983, 12815.0, 12833.42249598768, 751.8308380614372, 852.7484392104344, 887.6271965774358, 888.7022847346115, 896.3680605173337, 883.1433509495811, 895.4806212396827, 899.1008991008991, 899.1458114790942, 899.2850683706437, 961.711486554031, 961.7691753979065, 963.6627180486844, 965.0060437749095, 966.0387914025555, 951.1487218939045, 956.7273327101777, 956.9043095690411, 958.7171784323641, 959.0649117110831, 704.0917216790385, 706.7067167125637, 707.3174386716843, 708.2917082917083, 710.683745733149, 13594.0, 13656.385462654105, 13668.863311366858, 13669.316534173351, 13683.452661893512, 12374.938125309405, 12597.74804503914, 12718.618441446772, 12753.426095825711, 12863.035272354517, 10643.946780266126, 10816.72958176044, 10912.672619821338, 10938.398388088652, 11236.157288203418, 3834.65488106069, 3853.8265778040054, 3900.921981560353, 3922.293987082324, 3960.980195099006, 51382.22926656103, 52342.0, 53882.73058634682, 53884.73057634726, 54144.45855541473, 10164.440955747357, 10230.386176829414, 10285.43430111351, 10293.74265643365, 10364.06723394883, 18489.5377615558, 18521.814781852278, 18615.162317695736, 18623.255069797327, 18661.533461663297, 7686.692532298757, 8168.591570421455, 8318.0, 8356.874646880302, 8487.915120848837, 4611.930821037688, 4623.930641040387, 4683.859484215479, 4734.573888349996, 4746.0745154694505, 3318.2699806042633, 3331.3503866746237, 3360.9495857562156, 3362.1090411041096, 3366.7474939379154, 668.7124536449373, 669.10340144207, 677.6137601567059, 680.8365992161846, 689.7999580121809, 692.944564434844, 695.2421860172335, 701.7122979578348, 707.4552594502204, 728.8906664000336, 8373.706920257884, 8501.234888860032, 8503.532305723245, 8509.149085091565, 8546.0, 557.289455943667, 690.1132045321738, 702.2205352059312, 703.8134894252925, 706.1702499562992, 3956.66368358687, 4042.130941847458, 4135.483064616923, 4217.5782421758195, 4279.593438623326, 61168.0, 63124.0, 63185.68407158027, 64731.0, 64817.0, 53535.732321338146, 54055.72972135114, 54228.18657720138, 55116.9999999992, 55234.0, 49431.0, 51387.22919156215, 51631.225531617056, 51849.740751296005, 52198.47801521936, 8778.166074222938, 8924.598393072198, 9135.40619859707, 9159.358844880795, 9510.286728495528, 37199.628003720696, 37986.43020354752, 38166.618333817416, 38369.2326153481, 39462.210755785294, 46886.53113468958, 47035.0, 47430.28854567115, 48104.51895481, 48275.75862120667, 10814.621488247874, 10868.891311086787, 10920.18098642589, 11030.944845275722, 11115.388653623804, 11876.0, 12716.109872308849, 12730.936345318585, 12922.806157907828, 12959.639237880265, 11603.825942610698, 11706.297622142698, 11876.76246475083, 11976.16166868311, 12033.278003319829, 11498.25261358009, 11584.42077896085, 11650.592229271935, 11724.296542207494, 11831.645050648494, 11328.546858125583, 11469.369184694588, 11559.76880462403, 11688.123390745557, 11892.46483908209, 10074.597016119566, 10145.34055286404, 10179.592816287266, 10277.331973421704, 10311.07200351972, 10106.733825028236, 10281.485925703835, 10293.588256469657, 10319.0, 10350.689479315633], "unit": "score", "name": "yui.html", "value": 6694.4292978357435}], "name": "dromaeo_css", "value": 7344.030325793476}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 110.0, 114.0, 122.0, 110.0, 118.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 158.0, 167.0, 131.0, 151.0, 168.0, 128.0, 172.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 162.0, 162.0, 160.0, 163.0, 164.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 75.0, 164.0, 76.0, 75.0, 76.0, 73.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 147.0, 93.0, 93.0, 94.0, 141.0, 94.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 54.0, 60.0, 55.0, 58.0, 56.0, 64.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 68.0, 65.0, 69.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [79.0, 85.0, 88.0, 80.0, 80.0, 79.0, 91.0, 78.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 120.0, 134.0, 112.0, 114.0, 115.0, 113.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 145.0, 145.0, 145.0, 136.0, 147.0, 144.0, 150.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 71.0, 67.0, 74.0, 67.0, 70.0, 68.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1520.3999999999999}]} 15:32:43 INFO - Return code: 0 15:32:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:32:43 ERROR - # TBPL SUCCESS # 15:32:43 INFO - Running post-action listener: _resource_record_post_action 15:32:43 INFO - Running post-run listener: _resource_record_post_run 15:32:44 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261566464; Read time: 52; Write time: 160048 15:32:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14065664; Read time: 0; Write time: 7288 15:32:44 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247500800; Read time: 52; Write time: 152760 15:32:44 INFO - Running post-run listener: _upload_blobber_files 15:32:44 INFO - Blob upload gear active. 15:32:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:32:44 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 15:32:44 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'] 15:32:44 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 15:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:32:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:45 INFO - (blobuploader) - INFO - Done attempting. 15:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:46 INFO - (blobuploader) - INFO - Done attempting. 15:32:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:46 INFO - Return code: 0 15:32:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:32:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a124527016e6bebb046fe71f9fa117d8e418f4e46e4576e7aba16221bfe9f3996b7a26bd1d1ab6a097adec84c15d106ff05c062680ad7cb0a5a6af195a98b3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc8db19311948215abd3914d91477e9df3a7a6a4652ecc24ca4cb06cb9616edbbebebc312487248ee96d902231d66c9d0fe06768386da3485a1d4656a874bdc4"} 15:32:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:32:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:32:46 INFO - Contents: 15:32:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a124527016e6bebb046fe71f9fa117d8e418f4e46e4576e7aba16221bfe9f3996b7a26bd1d1ab6a097adec84c15d106ff05c062680ad7cb0a5a6af195a98b3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc8db19311948215abd3914d91477e9df3a7a6a4652ecc24ca4cb06cb9616edbbebebc312487248ee96d902231d66c9d0fe06768386da3485a1d4656a874bdc4"} 15:32:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:46 INFO - Copying logs to upload dir... 15:32:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:32:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1934.837713 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 15 secs) (at 2016-04-06 15:32:46.317097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 15:32:46.320683) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 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/5a124527016e6bebb046fe71f9fa117d8e418f4e46e4576e7aba16221bfe9f3996b7a26bd1d1ab6a097adec84c15d106ff05c062680ad7cb0a5a6af195a98b3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc8db19311948215abd3914d91477e9df3a7a6a4652ecc24ca4cb06cb9616edbbebebc312487248ee96d902231d66c9d0fe06768386da3485a1d4656a874bdc4"} build_url:https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010437 build_url: 'https://queue.taskcluster.net/v1/task/ZRF8PJpvTFKAzhvqo1I_Pg/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/5a124527016e6bebb046fe71f9fa117d8e418f4e46e4576e7aba16221bfe9f3996b7a26bd1d1ab6a097adec84c15d106ff05c062680ad7cb0a5a6af195a98b3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc8db19311948215abd3914d91477e9df3a7a6a4652ecc24ca4cb06cb9616edbbebebc312487248ee96d902231d66c9d0fe06768386da3485a1d4656a874bdc4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 15:32:46.344019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:32:46.344357) ========= 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=a0d2d2de893abaa8702a9954000001a7-1459980021.213191-1977485861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:32:46.394329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 15:32:46.394645) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 15:32:46.394944) ========= ========= Total master_lag: 0.46 =========