builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1460275273.42 results: success (0) buildid: 20160409223044 builduid: 727d024016e446fb962bc93c6d7ebca3 revision: 677502617cb90c9243eb46ea10f1cd016eedd3e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.415790) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.416243) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.416581) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.451570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.452007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.520896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.521186) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004706 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.579706) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.580015) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.580407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.580767) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-10 01:01:13-- 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% 97.1M=0s 2016-04-10 01:01:13 (97.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.694026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.694349) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.745330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:13.745716) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 677502617cb90c9243eb46ea10f1cd016eedd3e3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 677502617cb90c9243eb46ea10f1cd016eedd3e3 --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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-10 01:01:13,968 truncating revision to first 12 chars 2016-04-10 01:01:13,968 Setting DEBUG logging. 2016-04-10 01:01:13,968 attempt 1/10 2016-04-10 01:01:13,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/677502617cb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 01:01:14,576 unpacking tar archive at: mozilla-inbound-677502617cb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:14.636154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:14.636539) ========= echo 677502617cb90c9243eb46ea10f1cd016eedd3e3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'677502617cb90c9243eb46ea10f1cd016eedd3e3'] 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 677502617cb90c9243eb46ea10f1cd016eedd3e3 program finished with exit code 0 elapsedTime=0.004464 script_repo_revision: '677502617cb90c9243eb46ea10f1cd016eedd3e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:14.687124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:14.687480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 01:01:14.697529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-10 01:01:14.697864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:01:15 INFO - MultiFileLogger online at 20160410 01:01:15 in /builds/slave/test-pgo 01:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:01:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:01:15 INFO - {'append_to_log': False, 01:01:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:01:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:01:15 INFO - 'branch': 'Mozilla-Inbound', 01:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 01:01:15 INFO - 'config_files': ('talos/linux_config.py',), 01:01:15 INFO - 'default_actions': ('clobber', 01:01:15 INFO - 'read-buildbot-config', 01:01:15 INFO - 'download-and-extract', 01:01:15 INFO - 'populate-webroot', 01:01:15 INFO - 'create-virtualenv', 01:01:15 INFO - 'install', 01:01:15 INFO - 'run-tests'), 01:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:01:15 INFO - 'download_minidump_stackwalk': True, 01:01:15 INFO - 'download_symbols': 'ondemand', 01:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 01:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 01:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:01:15 INFO - 'installer_path': 'installer.exe', 01:01:15 INFO - 'log_level': 'info', 01:01:15 INFO - 'log_name': 'talos', 01:01:15 INFO - 'log_to_console': True, 01:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:01:15 INFO - 'opt_config_files': (), 01:01:15 INFO - 'pip_index': False, 01:01:15 INFO - 'sps_profile': False, 01:01:15 INFO - 'sps_profile_interval': 0, 01:01:15 INFO - 'suite': 'dromaeojs', 01:01:15 INFO - 'system_bits': '32', 01:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:01:15 INFO - 'title': 'talos-linux64-ix-009', 01:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:01:15 INFO - 'use_talos_json': True, 01:01:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:01:15 INFO - 'work_dir': 'build'} 01:01:15 INFO - ##### 01:01:15 INFO - ##### Running clobber step. 01:01:15 INFO - ##### 01:01:15 INFO - Running pre-action listener: _resource_record_pre_action 01:01:15 INFO - Running main action method: clobber 01:01:15 INFO - rmtree: /builds/slave/test-pgo/build 01:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:01:15 INFO - Running post-action listener: _resource_record_post_action 01:01:15 INFO - ##### 01:01:15 INFO - ##### Running read-buildbot-config step. 01:01:15 INFO - ##### 01:01:15 INFO - Running pre-action listener: _resource_record_pre_action 01:01:15 INFO - Running main action method: read_buildbot_config 01:01:15 INFO - Using buildbot properties: 01:01:15 INFO - { 01:01:15 INFO - "project": "", 01:01:15 INFO - "product": "firefox", 01:01:15 INFO - "script_repo_revision": "production", 01:01:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:01:15 INFO - "repository": "", 01:01:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:01:15 INFO - "buildid": "20160409223044", 01:01:15 INFO - "pgo_build": "True", 01:01:15 INFO - "basedir": "/builds/slave/test-pgo", 01:01:15 INFO - "buildnumber": 1689, 01:01:15 INFO - "slavename": "talos-linux64-ix-009", 01:01:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:01:15 INFO - "platform": "ubuntu64_hw", 01:01:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:01:15 INFO - "branch": "mozilla-inbound", 01:01:15 INFO - "repo_path": "integration/mozilla-inbound", 01:01:15 INFO - "revision": "677502617cb90c9243eb46ea10f1cd016eedd3e3", 01:01:15 INFO - "stage_platform": "linux64-pgo", 01:01:15 INFO - "builduid": "727d024016e446fb962bc93c6d7ebca3", 01:01:15 INFO - "slavebuilddir": "test" 01:01:15 INFO - } 01:01:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:01:15 INFO - Running post-action listener: _resource_record_post_action 01:01:15 INFO - ##### 01:01:15 INFO - ##### Running download-and-extract step. 01:01:15 INFO - ##### 01:01:15 INFO - Running pre-action listener: _resource_record_pre_action 01:01:15 INFO - Running main action method: download_and_extract 01:01:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:15 INFO - https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:01:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:01:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:01:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:01:17 INFO - Downloaded 1361 bytes. 01:01:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:01:17 INFO - Using the following test package requirements: 01:01:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:01:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:01:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:01:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'jsshell-linux-x86_64.zip'], 01:01:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:01:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:01:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:01:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:01:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:01:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:01:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:01:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:17 INFO - https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:01:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:01:19 INFO - Downloaded 23762349 bytes. 01:01:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:01:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:01:20 INFO - Return code: 0 01:01:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:20 INFO - https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:01:42 INFO - Downloaded 23762349 bytes. 01:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:01:44 INFO - Return code: 0 01:01:44 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')]} 01:01:44 INFO - https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:01:45 INFO - Downloaded 10841046 bytes. 01:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:01:45 INFO - Return code: 0 01:01:45 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')]} 01:01:45 INFO - https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:01:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:01:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:01:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:01:47 INFO - Downloaded 57789862 bytes. 01:01:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:01:47 INFO - mkdir: /builds/slave/test-pgo/properties 01:01:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:01:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:01:47 INFO - Contents: 01:01:47 INFO - build_url:https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:01:48 INFO - Running post-action listener: _resource_record_post_action 01:01:48 INFO - Running post-action listener: set_extra_try_arguments 01:01:48 INFO - ##### 01:01:48 INFO - ##### Running populate-webroot step. 01:01:48 INFO - ##### 01:01:48 INFO - Running pre-action listener: _resource_record_pre_action 01:01:48 INFO - Running main action method: populate_webroot 01:01:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:01:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:01:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:01:48 INFO - '--tppagecycles', 01:01:48 INFO - '7'], 01:01:48 INFO - 'tests': ['tsvgm']}}, 01:01:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:01:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:01:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:01:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:01:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['damp', 'tps']}, 01:01:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'tests': ['damp', 'tps']}, 01:01:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['dromaeo_dom']}, 01:01:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:01:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'other-e10s': {'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['a11yr', 01:01:48 INFO - 'ts_paint', 01:01:48 INFO - 'tpaint', 01:01:48 INFO - 'sessionrestore', 01:01:48 INFO - 'sessionrestore_no_auto_restore', 01:01:48 INFO - 'tabpaint']}, 01:01:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['tsvgx', 01:01:48 INFO - 'tsvgr_opacity', 01:01:48 INFO - 'tart', 01:01:48 INFO - 'tscrollx', 01:01:48 INFO - 'cart']}, 01:01:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:01:48 INFO - 'tsvgr_opacity', 01:01:48 INFO - 'tart', 01:01:48 INFO - 'tscrollx', 01:01:48 INFO - 'cart']}, 01:01:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'talos_options': ['--disable-e10s'], 01:01:48 INFO - 'tests': ['tp5o']}, 01:01:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'tests': ['tp5o']}, 01:01:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'talos_options': ['--disable-e10s', 01:01:48 INFO - '--xperf_path', 01:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:48 INFO - 'tests': ['tp5n']}, 01:01:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:48 INFO - 'talos_options': ['--xperf_path', 01:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:48 INFO - 'tests': ['tp5n']}}, 01:01:48 INFO - 'talos.zip': {'path': '', 01:01:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:01:48 INFO - Running post-action listener: _resource_record_post_action 01:01:48 INFO - ##### 01:01:48 INFO - ##### Running create-virtualenv step. 01:01:48 INFO - ##### 01:01:48 INFO - Running pre-action listener: _resource_record_pre_action 01:01:48 INFO - Running main action method: create_virtualenv 01:01:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:01:48 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 01:01:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:01:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:01:48 INFO - Using real prefix '/usr' 01:01:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:01:48 INFO - Installing distribute.............................................................................................................................................................................................done. 01:01:50 INFO - Installing pip.................done. 01:01:50 INFO - Return code: 0 01:01:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:01: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')]} 01:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:01: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:01: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 pip>=1.5 01:01:50 INFO - Using env: {'DISPLAY': ':0', 01:01:50 INFO - 'HOME': '/home/cltbld', 01:01:50 INFO - 'LANG': 'en_US.UTF-8', 01:01:50 INFO - 'LANGUAGE': 'en_US:en', 01:01:50 INFO - 'LOGNAME': 'cltbld', 01:01:50 INFO - 'MAIL': '/var/mail/cltbld', 01:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:50 INFO - 'MOZ_NO_REMOTE': '1', 01:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:50 INFO - 'NO_EM_RESTART': '1', 01:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:01:50 INFO - 'SHELL': '/bin/bash', 01:01:50 INFO - 'SHLVL': '1', 01:01:50 INFO - 'TERM': 'linux', 01:01:50 INFO - 'TMOUT': '86400', 01:01:50 INFO - 'USER': 'cltbld', 01:01:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:50 INFO - '_': '/tools/buildbot/bin/python'} 01:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:50 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 01:01:50 INFO - Cleaning up... 01:01:50 INFO - Return code: 0 01:01:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:01: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')]} 01:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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', '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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:01: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:01: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 psutil>=0.7.1 01:01:50 INFO - Using env: {'DISPLAY': ':0', 01:01:50 INFO - 'HOME': '/home/cltbld', 01:01:50 INFO - 'LANG': 'en_US.UTF-8', 01:01:50 INFO - 'LANGUAGE': 'en_US:en', 01:01:50 INFO - 'LOGNAME': 'cltbld', 01:01:50 INFO - 'MAIL': '/var/mail/cltbld', 01:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:50 INFO - 'MOZ_NO_REMOTE': '1', 01:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:50 INFO - 'NO_EM_RESTART': '1', 01:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:01:50 INFO - 'SHELL': '/bin/bash', 01:01:50 INFO - 'SHLVL': '1', 01:01:50 INFO - 'TERM': 'linux', 01:01:50 INFO - 'TMOUT': '86400', 01:01:50 INFO - 'USER': 'cltbld', 01:01:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:50 INFO - '_': '/tools/buildbot/bin/python'} 01:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:51 INFO - Downloading/unpacking psutil>=0.7.1 01:01:51 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 01:01:51 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 01:01:51 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 01:01:51 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 01:01:51 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 01:01:51 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 01:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:53 INFO - Installing collected packages: psutil 01:01:53 INFO - Running setup.py install for psutil 01:01:53 INFO - building 'psutil._psutil_linux' extension 01:01:53 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 01:01:53 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 01:01:53 INFO - building 'psutil._psutil_posix' extension 01:01:53 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 01:01:53 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 01:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:53 INFO - Successfully installed psutil 01:01:53 INFO - Cleaning up... 01:01:53 INFO - Return code: 0 01:01:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:01: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')]} 01:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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', '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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:01: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:01: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 mozsystemmonitor==0.0.0 01:01:53 INFO - Using env: {'DISPLAY': ':0', 01:01:53 INFO - 'HOME': '/home/cltbld', 01:01:53 INFO - 'LANG': 'en_US.UTF-8', 01:01:53 INFO - 'LANGUAGE': 'en_US:en', 01:01:53 INFO - 'LOGNAME': 'cltbld', 01:01:53 INFO - 'MAIL': '/var/mail/cltbld', 01:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:53 INFO - 'MOZ_NO_REMOTE': '1', 01:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:53 INFO - 'NO_EM_RESTART': '1', 01:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:01:53 INFO - 'SHELL': '/bin/bash', 01:01:53 INFO - 'SHLVL': '1', 01:01:53 INFO - 'TERM': 'linux', 01:01:53 INFO - 'TMOUT': '86400', 01:01:53 INFO - 'USER': 'cltbld', 01:01:53 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:53 INFO - '_': '/tools/buildbot/bin/python'} 01:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:01:55 INFO - Installing collected packages: mozsystemmonitor 01:01:55 INFO - Running setup.py install for mozsystemmonitor 01:01:55 INFO - Successfully installed mozsystemmonitor 01:01:55 INFO - Cleaning up... 01:01:55 INFO - Return code: 0 01:01:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:01:55 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')]} 01:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:55 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')]} 01:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:55 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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:01:55 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 01:01:55 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 01:01:55 INFO - Using env: {'DISPLAY': ':0', 01:01:55 INFO - 'HOME': '/home/cltbld', 01:01:55 INFO - 'LANG': 'en_US.UTF-8', 01:01:55 INFO - 'LANGUAGE': 'en_US:en', 01:01:55 INFO - 'LOGNAME': 'cltbld', 01:01:55 INFO - 'MAIL': '/var/mail/cltbld', 01:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:55 INFO - 'MOZ_NO_REMOTE': '1', 01:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:55 INFO - 'NO_EM_RESTART': '1', 01:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:01:55 INFO - 'SHELL': '/bin/bash', 01:01:55 INFO - 'SHLVL': '1', 01:01:55 INFO - 'TERM': 'linux', 01:01:55 INFO - 'TMOUT': '86400', 01:01:55 INFO - 'USER': 'cltbld', 01:01:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:55 INFO - '_': '/tools/buildbot/bin/python'} 01:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:01:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:01:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:58 INFO - Downloading docopt-0.6.1.tar.gz 01:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:01:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:01:58 INFO - Running setup.py install for blobuploader 01:01:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:01:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:01:58 INFO - Running setup.py install for requests 01:01:59 INFO - Running setup.py install for docopt 01:01:59 INFO - Successfully installed blobuploader requests docopt 01:01:59 INFO - Cleaning up... 01:01:59 INFO - Return code: 0 01:01:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:59 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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:01:59 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 01:01:59 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 01:01:59 INFO - Using env: {'DISPLAY': ':0', 01:01:59 INFO - 'HOME': '/home/cltbld', 01:01:59 INFO - 'LANG': 'en_US.UTF-8', 01:01:59 INFO - 'LANGUAGE': 'en_US:en', 01:01:59 INFO - 'LOGNAME': 'cltbld', 01:01:59 INFO - 'MAIL': '/var/mail/cltbld', 01:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:59 INFO - 'MOZ_NO_REMOTE': '1', 01:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:01:59 INFO - 'NO_EM_RESTART': '1', 01:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:01:59 INFO - 'SHELL': '/bin/bash', 01:01:59 INFO - 'SHLVL': '1', 01:01:59 INFO - 'TERM': 'linux', 01:01:59 INFO - 'TMOUT': '86400', 01:01:59 INFO - 'USER': 'cltbld', 01:01:59 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:59 INFO - '_': '/tools/buildbot/bin/python'} 01:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:01:59 INFO - Running setup.py (path:/tmp/pip-CVDQQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:01:59 INFO - Running setup.py (path:/tmp/pip-qcmWEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:01:59 INFO - Running setup.py (path:/tmp/pip-WhxUaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:01:59 INFO - Running setup.py (path:/tmp/pip-1IyOvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:01:59 INFO - Running setup.py (path:/tmp/pip-07G3ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:01:59 INFO - Running setup.py (path:/tmp/pip-ny6jc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:01:59 INFO - Running setup.py (path:/tmp/pip-l4SkRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:02:00 INFO - Running setup.py (path:/tmp/pip-AgzayM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:02:00 INFO - Running setup.py (path:/tmp/pip-iIjyEm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:02:00 INFO - Running setup.py (path:/tmp/pip-wqtKI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:02:00 INFO - Running setup.py (path:/tmp/pip-euIYEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:02:00 INFO - Running setup.py (path:/tmp/pip-MXXzFM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:02:00 INFO - Running setup.py (path:/tmp/pip-WjJqhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:02:00 INFO - Running setup.py (path:/tmp/pip-uH7qdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:02:00 INFO - Running setup.py (path:/tmp/pip-na7eaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:02:00 INFO - Running setup.py (path:/tmp/pip-iL1TWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:02:00 INFO - Running setup.py (path:/tmp/pip-ryhH_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:02:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:02:00 INFO - Running setup.py install for manifestparser 01:02:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:02:00 INFO - Running setup.py install for mozcrash 01:02:01 INFO - Running setup.py install for mozdebug 01:02:01 INFO - Running setup.py install for mozdevice 01:02:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for mozfile 01:02:01 INFO - Running setup.py install for mozhttpd 01:02:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for mozinfo 01:02:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for mozInstall 01:02:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for mozleak 01:02:01 INFO - Running setup.py install for mozlog 01:02:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for moznetwork 01:02:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:02:01 INFO - Running setup.py install for mozprocess 01:02:02 INFO - Running setup.py install for mozprofile 01:02:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:02:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:02:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:02:02 INFO - Running setup.py install for mozrunner 01:02:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:02:02 INFO - Running setup.py install for mozscreenshot 01:02:02 INFO - Running setup.py install for moztest 01:02:02 INFO - Running setup.py install for mozversion 01:02:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:02:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:02:02 INFO - Cleaning up... 01:02:02 INFO - Return code: 0 01:02:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:02 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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:02:02 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 01:02:02 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 01:02:02 INFO - Using env: {'DISPLAY': ':0', 01:02:02 INFO - 'HOME': '/home/cltbld', 01:02:02 INFO - 'LANG': 'en_US.UTF-8', 01:02:02 INFO - 'LANGUAGE': 'en_US:en', 01:02:02 INFO - 'LOGNAME': 'cltbld', 01:02:02 INFO - 'MAIL': '/var/mail/cltbld', 01:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:02 INFO - 'MOZ_NO_REMOTE': '1', 01:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:02 INFO - 'NO_EM_RESTART': '1', 01:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 01:02:02 INFO - 'SHELL': '/bin/bash', 01:02:02 INFO - 'SHLVL': '1', 01:02:02 INFO - 'TERM': 'linux', 01:02:02 INFO - 'TMOUT': '86400', 01:02:02 INFO - 'USER': 'cltbld', 01:02:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:02 INFO - '_': '/tools/buildbot/bin/python'} 01:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:02:02 INFO - Running setup.py (path:/tmp/pip-U7RDen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:02:02 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)) 01:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:02:02 INFO - Running setup.py (path:/tmp/pip-Bkntm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:02:02 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)) 01:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:02:02 INFO - Running setup.py (path:/tmp/pip-98QFoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:02:03 INFO - Running setup.py (path:/tmp/pip-R6HxbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:02:03 INFO - Running setup.py (path:/tmp/pip-SbQ3FD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:02:03 INFO - Running setup.py (path:/tmp/pip-I34ot_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:02:03 INFO - Running setup.py (path:/tmp/pip-69rkTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:02:03 INFO - Running setup.py (path:/tmp/pip-7bxhs9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:02:03 INFO - Running setup.py (path:/tmp/pip-SuILPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:02:03 INFO - Running setup.py (path:/tmp/pip-vTPCrN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:02:03 INFO - Running setup.py (path:/tmp/pip-Snujjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:02:03 INFO - Running setup.py (path:/tmp/pip-RasAx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:02:03 INFO - Running setup.py (path:/tmp/pip-voOScn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:02:03 INFO - Running setup.py (path:/tmp/pip-E9RYb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:02:03 INFO - Running setup.py (path:/tmp/pip-kydyPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:02:03 INFO - Running setup.py (path:/tmp/pip-YlyGr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:02:03 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)) 01:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:02:03 INFO - Running setup.py (path:/tmp/pip-y5lqz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:02:04 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)) 01:02:04 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)) 01:02:04 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)) 01:02:04 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)) 01:02:04 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)) 01:02:04 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)) 01:02:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:02:04 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 01:02:04 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 01:02:04 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 01:02:04 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 01:02:04 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 01:02:04 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 01:02:05 INFO - Downloading blessings-1.6.tar.gz 01:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:02:05 INFO - Installing collected packages: blessings 01:02:05 INFO - Running setup.py install for blessings 01:02:06 INFO - Successfully installed blessings 01:02:06 INFO - Cleaning up... 01:02:06 INFO - Return code: 0 01:02:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:02:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:02:06 INFO - Reading from file tmpfile_stdout 01:02:06 INFO - Current package versions: 01:02:06 INFO - argparse == 1.2.1 01:02:06 INFO - blessings == 1.6 01:02:06 INFO - blobuploader == 1.2.4 01:02:06 INFO - docopt == 0.6.1 01:02:06 INFO - manifestparser == 1.1 01:02:06 INFO - mozInstall == 1.12 01:02:06 INFO - mozcrash == 0.17 01:02:06 INFO - mozdebug == 0.1 01:02:06 INFO - mozdevice == 0.48 01:02:06 INFO - mozfile == 1.2 01:02:06 INFO - mozhttpd == 0.7 01:02:06 INFO - mozinfo == 0.9 01:02:06 INFO - mozleak == 0.1 01:02:06 INFO - mozlog == 3.1 01:02:06 INFO - moznetwork == 0.27 01:02:06 INFO - mozprocess == 0.22 01:02:06 INFO - mozprofile == 0.28 01:02:06 INFO - mozrunner == 6.11 01:02:06 INFO - mozscreenshot == 0.1 01:02:06 INFO - mozsystemmonitor == 0.0 01:02:06 INFO - moztest == 0.7 01:02:06 INFO - mozversion == 1.4 01:02:06 INFO - psutil == 3.1.1 01:02:06 INFO - requests == 1.2.3 01:02:06 INFO - wsgiref == 0.1.2 01:02:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:06 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 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:02:06 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 01:02:06 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 01:02:06 INFO - Using env: {'DISPLAY': ':0', 01:02:06 INFO - 'HOME': '/home/cltbld', 01:02:06 INFO - 'LANG': 'en_US.UTF-8', 01:02:06 INFO - 'LANGUAGE': 'en_US:en', 01:02:06 INFO - 'LOGNAME': 'cltbld', 01:02:06 INFO - 'MAIL': '/var/mail/cltbld', 01:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:06 INFO - 'MOZ_NO_REMOTE': '1', 01:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:06 INFO - 'NO_EM_RESTART': '1', 01:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 01:02:06 INFO - 'SHELL': '/bin/bash', 01:02:06 INFO - 'SHLVL': '1', 01:02:06 INFO - 'TERM': 'linux', 01:02:06 INFO - 'TMOUT': '86400', 01:02:06 INFO - 'USER': 'cltbld', 01:02:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:06 INFO - '_': '/tools/buildbot/bin/python'} 01:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 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)) 01:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:02:06 INFO - Cleaning up... 01:02:06 INFO - Return code: 0 01:02:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:02:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:02:06 INFO - Using env: {'DISPLAY': ':0', 01:02:06 INFO - 'HOME': '/home/cltbld', 01:02:06 INFO - 'LANG': 'en_US.UTF-8', 01:02:06 INFO - 'LANGUAGE': 'en_US:en', 01:02:06 INFO - 'LOGNAME': 'cltbld', 01:02:06 INFO - 'MAIL': '/var/mail/cltbld', 01:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:06 INFO - 'MOZ_NO_REMOTE': '1', 01:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:06 INFO - 'NO_EM_RESTART': '1', 01:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 01:02:06 INFO - 'SHELL': '/bin/bash', 01:02:06 INFO - 'SHLVL': '1', 01:02:06 INFO - 'TERM': 'linux', 01:02:06 INFO - 'TMOUT': '86400', 01:02:06 INFO - 'USER': 'cltbld', 01:02:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:06 INFO - '_': '/tools/buildbot/bin/python'} 01:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:06 INFO - Downloading/unpacking jsonschema 01:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:02:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:02:08 INFO - warning: no files found matching '*.txt' 01:02:08 INFO - no previously-included directories found matching 'build' 01:02:08 INFO - no previously-included directories found matching 'dist' 01:02:08 INFO - no previously-included directories found matching '.git*' 01:02:08 INFO - Installing collected packages: jsonschema, functools32 01:02:08 INFO - Running setup.py install for functools32 01:02:09 INFO - warning: no files found matching '*.txt' 01:02:09 INFO - no previously-included directories found matching 'build' 01:02:09 INFO - no previously-included directories found matching 'dist' 01:02:09 INFO - no previously-included directories found matching '.git*' 01:02:09 INFO - Successfully installed jsonschema functools32 01:02:09 INFO - Cleaning up... 01:02:09 INFO - Return code: 0 01:02:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d15006f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27548d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', '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 01:02:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:02:09 INFO - Using env: {'DISPLAY': ':0', 01:02:09 INFO - 'HOME': '/home/cltbld', 01:02:09 INFO - 'LANG': 'en_US.UTF-8', 01:02:09 INFO - 'LANGUAGE': 'en_US:en', 01:02:09 INFO - 'LOGNAME': 'cltbld', 01:02:09 INFO - 'MAIL': '/var/mail/cltbld', 01:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:09 INFO - 'MOZ_NO_REMOTE': '1', 01:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:09 INFO - 'NO_EM_RESTART': '1', 01:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:02:09 INFO - 'SHELL': '/bin/bash', 01:02:09 INFO - 'SHLVL': '1', 01:02:09 INFO - 'TERM': 'linux', 01:02:09 INFO - 'TMOUT': '86400', 01:02:09 INFO - 'USER': 'cltbld', 01:02:09 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:09 INFO - '_': '/tools/buildbot/bin/python'} 01:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:09 INFO - Downloading/unpacking flake8 01:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:02:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:02:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:02:11 INFO - no previously-included directories found matching 'docs/_build' 01:02:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:02:11 INFO - Running setup.py install for pep8 01:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:02:12 INFO - no previously-included directories found matching 'docs/_build' 01:02:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:02:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:02:12 INFO - Cleaning up... 01:02:12 INFO - Return code: 0 01:02:12 INFO - Running post-action listener: _resource_record_post_action 01:02:12 INFO - Running post-action listener: _start_resource_monitoring 01:02:12 INFO - Starting resource monitoring. 01:02:12 INFO - ##### 01:02:12 INFO - ##### Running install step. 01:02:12 INFO - ##### 01:02:12 INFO - Running pre-action listener: _resource_record_pre_action 01:02:12 INFO - Running main action method: install 01:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:02:12 INFO - Reading from file tmpfile_stdout 01:02:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:02:12 INFO - Reading from file tmpfile_stdout 01:02:12 INFO - Output received: 01:02:12 INFO - Usage: mozinstall [options] installer 01:02:12 INFO - Options: 01:02:12 INFO - -h, --help show this help message and exit 01:02:12 INFO - -d DEST, --destination=DEST 01:02:12 INFO - Directory to install application into. [default: 01:02:12 INFO - "/builds/slave/test-pgo"] 01:02:12 INFO - --app=APP Application being installed. [default: firefox] 01:02:12 INFO - mkdir: /builds/slave/test-pgo/build/application 01:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:02:28 INFO - Reading from file tmpfile_stdout 01:02:28 INFO - Output received: 01:02:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:02:28 INFO - Running post-action listener: _resource_record_post_action 01:02:28 INFO - ##### 01:02:28 INFO - ##### Running run-tests step. 01:02:28 INFO - ##### 01:02:28 INFO - Running pre-action listener: _resource_record_pre_action 01:02:28 INFO - Running main action method: run_tests 01:02:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:02:28 INFO - Python 2.7.3 01:02:28 INFO - Return code: 0 01:02:28 INFO - grabbing minidump binary from tooltool 01:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:28 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 0x27e38b0>, '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 0x27e47b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e4c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:02:28 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 01:02:28 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 01:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:02:29 INFO - Return code: 0 01:02:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:02:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:02:30 INFO - Return code: 0 01:02:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 01:02:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 01:02:30 INFO - Using env: {'DISPLAY': ':0', 01:02:30 INFO - 'HOME': '/home/cltbld', 01:02:30 INFO - 'LANG': 'en_US.UTF-8', 01:02:30 INFO - 'LANGUAGE': 'en_US:en', 01:02:30 INFO - 'LOGNAME': 'cltbld', 01:02:30 INFO - 'MAIL': '/var/mail/cltbld', 01:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:30 INFO - 'MOZ_NO_REMOTE': '1', 01:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:30 INFO - 'NO_EM_RESTART': '1', 01:02:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:02:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:02:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:02:30 INFO - 'SHELL': '/bin/bash', 01:02:30 INFO - 'SHLVL': '1', 01:02:30 INFO - 'TERM': 'linux', 01:02:30 INFO - 'TMOUT': '86400', 01:02:30 INFO - 'USER': 'cltbld', 01:02:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910', 01:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:30 INFO - '_': '/tools/buildbot/bin/python'} 01:02:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:02:30 INFO - mozversion application_buildid: 20160409223044 01:02:30 INFO - mozversion application_changeset: 677502617cb90c9243eb46ea10f1cd016eedd3e3 01:02:30 INFO - mozversion application_display_name: Nightly 01:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:02:30 INFO - mozversion application_name: Firefox 01:02:30 INFO - mozversion application_remotingname: firefox 01:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:02:30 INFO - mozversion application_vendor: Mozilla 01:02:30 INFO - mozversion application_version: 48.0a1 01:02:30 INFO - mozversion platform_buildid: 20160409223044 01:02:30 INFO - mozversion platform_changeset: 677502617cb90c9243eb46ea10f1cd016eedd3e3 01:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:02:30 INFO - mozversion platform_version: 48.0a1 01:02:30 INFO - using testdate: 1460275350 01:02:30 INFO - actual date: 1460275350 01:02:30 INFO - starting webserver on 'localhost:41834' 01:02:30 INFO - SUITE-START | Running 2 tests 01:02:30 INFO - TEST-START | dromaeo_css 01:02:30 INFO - operating with platform_type : linux_ 01:02:30 INFO - Initialising browser for dromaeo_css test... 01:02:30 INFO - TEST-INFO | started process 3395 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkBOfMp/profile http://localhost:41834/getInfo.html) 01:02:35 INFO - PROCESS | 3395 | __metrics Screen width/height:1600/1200 01:02:35 INFO - PROCESS | 3395 | colorDepth:24 01:02:35 INFO - PROCESS | 3395 | Browser inner width/height: 1024/697 01:02:35 INFO - PROCESS | 3395 | __metrics 01:02:36 ERROR - PROCESS | 3395 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:02:37 INFO - TEST-INFO | 3395: exit 0 01:02:37 INFO - Browser initialized. 01:02:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:02:37 INFO - TEST-INFO | started process 3474 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkBOfMp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:02:48 INFO - PROCESS | 3474 | RSS: Main: 152473600 01:02:48 INFO - PROCESS | 3474 | 01:03:40 INFO - PROCESS | 3474 | 1460275420074 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] 01:05:47 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41834/tests/dromaeo/cssquery-ext.html) 01:05:48 INFO - PROCESS | 3474 | RSS: Main: 252321792 01:05:48 INFO - PROCESS | 3474 | 01:08:50 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-ext.html (next: http://localhost:41834/tests/dromaeo/cssquery-jquery.html) 01:08:51 INFO - PROCESS | 3474 | RSS: Main: 237551616 01:08:51 INFO - PROCESS | 3474 | 01:11:53 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41834/tests/dromaeo/cssquery-mootools.html) 01:11:53 INFO - PROCESS | 3474 | RSS: Main: 233291776 01:11:53 INFO - PROCESS | 3474 | 01:14:55 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41834/tests/dromaeo/cssquery-prototype.html) 01:14:56 INFO - PROCESS | 3474 | RSS: Main: 203382784 01:14:56 INFO - PROCESS | 3474 | 01:17:58 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41834/tests/dromaeo/cssquery-yui.html) 01:17:59 INFO - PROCESS | 3474 | RSS: Main: 219832320 01:17:59 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:41834/tests/dromaeo/cssquery-yui.html (next: http://localhost:41834/tests/dromaeo/cssquery-dojo.html) 01:21:02 INFO - PROCESS | 3474 | RSS: Main: 267059200 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | __start_tp_report 01:21:02 INFO - PROCESS | 3474 | _x_x_mozilla_page_load 01:21:02 INFO - PROCESS | 3474 | _x_x_mozilla_page_load_details 01:21:02 INFO - PROCESS | 3474 | |i|pagename|runs| 01:21:02 INFO - PROCESS | 3474 | |0;dojo.html;3112.828794416307;3168.4455220336436;3181.061586831886;3214.710676039156;3235.7573182011347;5368.114261146916;5376.247325374451;5381.112116500777;5467.972660136694;5478.58910581706;5418.214358917954;5464;5464.480874316933;5529.281193444846;5532.502074813266;4807.831725889595;4822.927656085161;4837.516248375152;4870.415550133971;5021.071101846152;4919.360483137187;4941.802327906879;4982.202847544394;4982.57648099912;4999.525045120708;4778.092162489116;4898.093852637274;4905.533974272438;4942.382202224722;4959.8264060758065;4853.490383509751;4860.246661767432;4861.197902346109;4871.975640121812;4902.558769710743;4819.42166939966;4819.927701084486;4842.733649649268;4845;4870.853874383739;5314.92027619586;5348.625596208267;5371.248025276464;5395.595330350239;5407.783688652449;5707.286589176353;5726.570507211975;5727.856803579903;5731.484166425042;5733.082706766939;5712.343080545749;5769.365369809318;5771.538276937835;5785.334686511063;5788.016037273674;5479.53423958968;5479.561635069185;5484.670919744788;5528.391876893538;5528.612997090206;5956.52347812174;5964.7315870785915;5968.791092311748;5969.522438204933;5973.372795856372;5536.280283563111;5657.547396208293;5722.141678748221;5725.541956643458;5733.627314224562;5769.9711501442225;5772;5774.2782152230975;5775.971120144456;5780.104083867007;5710.7430165642645;5733.512651424676;5737.053386191315;5738.081906894877;5739.655620662774;5680.091185410314;5721.971390143106;5798.449147330997;5839.5036421904615;5855.092460668603;4345.478542574911;4346.087321662423;4346.348047792856;4349.695521313478;4379.4525684289465;3896.337622604164;3902.31709450845;3916.373380259145;3945.2306800174265;3946.782926939046;5213.478652134832;5357.383900851374;5359.22291267764;5400;5458.072127738294;5738.856528586735;5740.368559458456;5773.076307790733;5784.248047753765;5790.044642634002;5423.891522169613;5430.185472179205;5432.945670543244;5437.864053398617;5441.238226648273;4892.633052521075;4921.212605983025;4961.727105009187;5000.399952005782;5003.174476211457;5886.970565147147;5907.675077870758;5912.142739302777;5912.674802885796;5912.940870591325;5657.886842263049;5728.570357223141;5734.569907256889;5739.942600573941;5740.712964351849;6024.849378765566;6075.848103797441;6084.513238940785;6119.082137679384;6125.387461253839;5692.1461780733225;5727.6849773262875;5731.942680573307;5732.59871808986;5744.310682718101;5723.828285151452;5735.799247026334;5835.037218859011;5836.854078647898;5840.182374467663;5604.551635869039;5610.7755689773585;5611.494965453129;5620.4098569649595;5654.773809047757;5515.972420137874;5546.916796247979;5550.361708403424;5577.832665020056;5596.664200148004;5419.674819510842;5448.5368743655645;5471.781128754806;5497.285352904097;5552.861178470571;5616.5787565931905;5620.747066382104;5621.353544342453;5630.211770352236;5666.291713535808;5515.393306736336;5515.558755299486;5525.751341189576;5537.5569954404355;5543.113101903838 01:21:02 INFO - PROCESS | 3474 | |1;ext.html;595.65749693926;656.3436563436563;657.1424291299853;664.1532046640534;667.9779936696852;28150.29624259392;28956.42087158258;35700.46449303256;36471.27057458849;36489.087772805695;38987.80506097466;39679.60320396795;39743.80128099355;39760.204795904065;39861;8533.95733021334;8734.563271836414;8743.95628021859;8751.737447876574;8752.256058235025;7869.606519674022;10215.540300686449;10556.736081597983;10571.682849514527;10599.364038157697;10288.331258468213;10414.16686665065;10432.895671043269;10437.11284540815;10440.477976101165;7936.36509079278;10275;10279.897201028007;10304.587816487332;10383.584656613726;10070.798584028278;10225.386476811414;10227.590896364136;10228.89771102287;10235.948820255926;35917.82041089804;36554.451683224506;36599.634003660154;36615.26769464622;36683.63316366829;3375.4599264117624;3527.9139853393276;3579.552555930509;3665.945010824813;3720.6465385788306;28533.28666783347;30948.0715578533;31202;31429;32516.512252316235;4318.892027699301;4356.6732495063;4363.083752411997;4367;4421.712588681726;212957;276043;278506;278970;279030;35201.47197792035;58976.1153582688;59335.70332148312;59357.70321148367;59550;33794;33835.15412114717;33987.15032124217;33990.49014264788;34045.319093618484;14150.575482735534;14414.927925360305;14418.783718244234;14419.279036048365;14421.855781442051;11819.645410637695;11928.34394108315;11929.463174157183;11934.522619095313;11944.163908526494;8458.87311690325;8635.309175265964;8662.177093176264;8667.4366166199;8711.172438618449;3344.9331013379597;3352.2792599591203;3369.79781213128;3371.224618337796;3392.3215356928713;966.5891995901713;1040.2977989856815;1045.8274384726435;1123.5730422439585;1174.0724827386439;30587.541186882216;30959.380812384075;31031.379372412426;31551.21121971969;31624;1102.8676558812995;1105.7733164701217;1147.7360207152235;1173.1729130962651;1195.8026925557185;15959.281832317574;16913.661726765396;16918.154092295335;16962.660746784994;17141.657166856592;433085;436736;437989;439434;441154;55737;56709.432905670415;56726.43273567294;56741.71629141911;56881.43118568844;1336.2784096587927;1349.8650134986424;1379.8413182484144;1380.5306195893243;1407.429990853706;29460.263493412836;30547.687431910996;31321.530177047818;31589.21026974252;31710.524342134424;44180.55819441893;44812.41500679873;44814.10371792481;44819;44886.77556612196;262040;263803;264266;265007;266864;25158;27726.722732772414;28499.715002849705;28503.437070366203;28751.5687264687;40292;41272.38091428691;41656.58343416527;41747;42098.158036839704;38236.42645360266;38263.80868095642;38543.22913541769;38712.80643596764;38847.6115238844;36880.44679329866;37840.43239351467;38210;38789.41815872708;38890;38579;38888.222235555695;39001.6099838998;39395.80302098471;39462.40806387964;32764.50853237251;33718.15704607405;34103.147421314665;34293.65706342905;34340.82829585836;26228.4754304909;26368.472630546898;26653;26688.19935401941;26692.065777698463 01:21:02 INFO - PROCESS | 3474 | |2;jquery.html;389.94540764292987;401.4780784979526;405.6511400195833;407.21814116895564;410.220580896297;17762.822371776296;17993.460196194133;18205.453836384928;18410.263589456423;18410.44768656941;16668.74996875048;16734.41429549966;17533.12334383279;17707.989641760898;17739.91130044348;5482.314710661178;5592.86017849555;5627.324721033461;5641.661500309974;5691.686957217351;5393;5606.747696353674;5615.326160860703;5644.238027866227;5652.689102099383;5478.58910581708;5575.498205161534;5576.749046292926;5583.5254003409755;5586;5485.341758988927;5592.133219351007;5613.887722245573;5632.5212356949705;5635.436456354373;4853.733044682541;5000.049990501793;5027;5037.420696619899;5039.798408063673;18937.81062189388;21658.35024949254;21874.453138671503;21964.341069767932;22056.117755289768;2226;2278.9886050569808;2279.5440911817536;2307.14635584833;2371.6086845670443;12068.396580170956;13135.86864131356;13151.276679782608;13613.863861361358;14026.43894244229;1697.3719723702309;1733.2027267456986;1861.0973677766272;1890.5179179309325;1938.5928954919484;72858.80724535193;76173.23826761717;76378.61810690966;77373.61313193398;78382.6080869592;9881.456519891475;9911.306208565475;10160.288779785493;10354.896451035393;10518.158547316196;14397.496087637091;14427.422903083969;14490.347934342979;14493.202873841828;14505.274736263145;7765.029371328584;7777.144514103444;7803.414743894231;7888.605569721606;7929.563873986871;7306.2693730626515;7362.8527429451115;7492.700291988368;7492.850142997218;7523.059617547807;6199.535034872402;6323.5573509854785;6330.52521060913;6386.904196437057;6413.0701048348665;1811.5471132216946;1882.868199226041;1892.2556581424099;1898.6487499812304;1899.202335019295;899.7660608241904;1029.4183786160795;1040.6409788622914;1094.518411898762;1141.5547936304847;18082.276708931495;18143.63712725738;18203.180856861472;18417.631647366976;18542.907285463487;994.1202036198017;999.7000899730052;1002.8595996560488;1017.7811770469384;1055.6358056470506;10215.336003159919;10703.785924281627;10787.6224332148;10789.892101078889;10809.405482698527;459858;464822;469637;470230.296649104;474106;61218.693906530185;75623;75866;77111;79066.20933790703;1048.0933992096782;1088.374184843702;1115.9274647148072;1120.9047230985457;1124.4096849154096;12670.366481676063;15607.375704971673;15710.528684139494;15823.129727865078;16132.193390330202;30780.23049423782;31364;31908.680913190572;32238.516422253215;32259.193520161243;37245.627543724215;38900.80549597234;39605.40591891181;39790.60209397869;40383.79808100941;8031.518108913484;8138.308243799106;8166.714165004197;8316.584170791315;8537.786555336166;12415;12696.492140314283;12722.61832145037;12819.230846149261;12872.935635321763;10385.688429347132;10770.353778773298;10963.287386319864;11015.614453494089;11154.219204655921;10561.366318020944;10676.46617669129;10715.41065241388;10875.728106797076;11003.889961100607;11031.669049928514;11073.390963497084;11392.088632909514;11447.427628618369;11522.942385288019;8394.959064674806;8417.62120704582;8453.196946290092;8522.232999030117;8588;8519.488830669932;10848.837267441153;10927.453627318444;11111.333320000826;11128.666140015812 01:21:02 INFO - PROCESS | 3474 | |3;mootools.html;1393.9721205575895;1534.248218372997;1568.0278227498948;1741.7213245880653;1853.3235369090287;7788.260115289046;8028.678852845894;8036;8043.718469853557;8045.718399856006;7857.567833769141;7933.722319718811;8004.559749213791;8008.27925486706;8014.799630009253;2025.250657256817;2281.0761641535205;2283.691701620285;2301.8618882867;2345.331580499558;2398.0767404549288;2417.069428270111;2420.104561312317;2420.5884999550117;2422.1038215860067;2304.8617082975074;2352.811775058;2353.0705371378294;2354.6585745066955;2354.8822558872075;1911.4170178095676;2267.807236384901;2331.48707284398;2333.8132949364012;2334.5447637710654;2254.4363909022745;2257.887105644711;2260.378395941113;2264.92072777452;2299.8275129365366;8304.335653147733;8311.210435008725;8374.49753014821;8383.664653413856;8388.370872184549;5009.398872135331;5153.330067091254;5170.017696637627;5186.92219616706;5235.502627250406;3234.75739319552;3275.5414242006136;3304;3353.3628610563915;3365.7139143172617;1121.3552207480732;1124.707576030238;1133.4162906103363;1138.7623320175894;1154.105568184655;11969.341686207255;11988.160828741991;11988.160828741991;11996.400179991053;12028.338441385808;4390.714603550759;4531.886702832456;4607.723536587815;4610.585047345755;4757.833475828329;9985.251106167067;10005.14956228714;10011.099001089937;10015.69952901414;10025.147862431775;4705.6000239979985;5302.09864323066;5328.387235467893;5347.25138480613;5361.08861493547;4639.188142075123;4691.507391723888;4712.740799256074;4732.171869922819;4738.384010078667;3905.628965248297;3964.6431821136234;3972.0467087899274;3995.92008159841;4012.297847876668;1245.5391505143155;1255.604484587352;1267.6704056945262;1272.37017676249;1287.2083668543778;1364.8976326775532;1380.882624976868;1409.971800563983;1420.218879616207;1431.2485944878813;8079.4344395892895;8174.386920980831;8185.713500027589;8191.426600137933;8200.876986845202;470.0763000703565;471.2342443529265;479.7505297245413;479.9616030717534;497.17717178070353;6266.874662506724;6286.622802631857;6332.461740751995;6361.9045714314325;6383.744650214032;9836.60653573849;10156.441395723159;10235.846462303072;10258.384496930208;10275.948620257;9947.751306217258;10048;10075.193984481224;10092.949535252423;10140.797184056426;7692.615369231516;7720.305172534387;7749.496282741717;7757.650905709256;7827.256410641094;7712.267334603203;7722.652480638272;8113.878291825509;8124.918750812652;8125.8374832504205;9395.2953528487;9396.201322887631;9407.85888211691;9551.379160354554;9578.185854202471;9495.620175193191;9581.664641737505;9802.65690700822;9831.655892043744;9877.456739879375;7029.05107810439;7325.230850760593;7398.297161769623;7516.736914207976;7554.093508778982;8080.393970452122;8098.7165449209;8107.391945604221;8152.918470815216;8163.102058773649;7101.751438699621;7252.854942901218;7304.780856574099;7341.302576255247;7348.595827229554;7383.520071195355;7426.368758655575;7572.20491848348;7597.6581053851605;7735.574543400167;7576.3181313679825;7592.16486186508;7659.808504787425;7689.577073260801;7689.92310076892;7032.578045317297;7073.045138906182;7148.785536433916;7205.819854503469;7208.783736487913;7013.403860671696;7075.964620176866;7081.291870812877;7082.964585177041;7185.173705023989 01:21:02 INFO - PROCESS | 3474 | |4;prototype.html;343.272262802858;343.9415299399102;345.1715881883481;346.2745548076779;354.83500172419804;5597.412271711468;5654.349749778777;5678.466813960238;5711.885762284752;5713;5599.580031497633;5603.831885043445;5612.719364031792;5613.4386561343845;5633.929553384864;4322.222000039991;4400.921774165334;4408.074304396081;4426.100903907945;4426.933595996046;4402.471703395597;4402.713823601472;4414.823407063714;4415.011037527589;4438.866833994985;4152.335626299792;4221.6490722968665;4377.912441751163;4382.320740285261;4399.802008909607;4368.563143685637;4372.606465418112;4383.956160438419;4397.087267038848;4420.911581768379;3893.3770596704676;3894.4547763313158;3900.4539364488996;3920.1179734559782;3925.2934471795065;5207.4792520748;5244.685318880841;5438.129899216106;5449;5467.480589344006;5044.52077052683;5091.847244582668;5100.719460429675;5104.116174361474;5106.310648062501;5933.406659334032;5951.49412299955;5961.105834124916;5971.4327138921735;5979.970100149515;3998.9400158997637;4213.852515161985;4222.577742225783;4231.132617813341;4244.0663054128045;6123.6938153092615;6177.536684748617;6203.193584833943;6204.162438070848;6205.968970155165;4333.566643335641;4334.414853994734;4335.263005289108;4337.7397356158735;4346.608805207483;4183.393407955829;4408.707472114483;4411.713238639478;4425.269830477935;4431.40176076232;5043.470435604282;5050.419201791841;5053.191489361684;5062.873428164326;5088.821891233789;5741.88516229673;5925.4520556160405;6063.272407311063;6071.180390647206;6073.5748497604745;1515.5756388211319;1520.8251051129262;1527.9847201528064;1533.6932613477127;1539.4765779634977;1002.4336250018716;1027.6505987964129;1036.103770238738;1037.3827572594294;1049.4280617063719;5786.363500014995;5802.88394232113;5829.183914252008;5843.795467158629;5849.356570777211;5946.910796338058;6171.475424588871;6172.969135154385;6173.81478555644;6188.9690551546955;5635.971820140955;5878.764849406061;5888.558358123158;5889.499392551681;5909.556783241274;3285.178705323669;3319.9502007469905;3322.186064414234;3332.5667663204113;3342.649021852719;6339.907830415952;6443.552699305849;6447.580907241015;6450.41946224842;6468.2561505427475;6333.746650133943;6365.904511432333;6375.585586936834;6376.936230637727;6383.904241436382;6191.659458729813;6418.967905160631;6446.645434501147;6451.1290975717675;6458.160439142881;6172.197614310111;6182.783602573888;6208;6220.968895155495;6230.563860529719;6012.579119461596;6085.53947052713;6098.573099882966;6142.969285153725;6183.350748171557;6354.491640668828;6443.743470023301;6447.742090316522;6454.225492940689;6460.903086453613;4373.125374925091;4376.321670141133;4376.49670287921;4392.12157568494;4394.1211757649235;6125.326214116354;6195.752169913333;6257.561970662192;6257.843553911189;6275.717592708431;6040.7583696651645;6060.515158787198;6065.696715164312;6069.241344831896;6069.575129740876;5956.315023772148;5976.940230597638;6051.612580879004;6087.66517841523;6088.391160883876;5882.205902203148;5920.79277225295;5924.437178468039;5926.2295901532525;5926.377730338252;6071.939280607314;6075.878482430238;6095.634261944298;6104.4200800923845;6107.755689772359;5659.801906933238;5730.312362516358;5795.971020144872;5874.676892770939;5985.102234664835 01:21:02 INFO - PROCESS | 3474 | |5;yui.html;756.833496630741;763.2634507700068;832.1927730101801;850.0437008365589;869.7477731457875;13034.804477932827;13064.542741004067;13204.603861884134;13212.801807972888;13252;12206.633800985963;12209.145359824815;12225.755484890296;12240.081993850474;12835.229886206835;702.6135625406006;836.5273620404482;838.2246422059586;860.1054902900976;864.7881269089082;847.7244895408986;848.8514509960763;850.421713235;855.0124606079987;855.4610595324937;888.3648191543045;896.4800415758876;897.7351681254013;898.2230370729337;898.2275243290765;726.2447055062728;858.6393714639835;882.4264228251624;883.2536506651869;883.514067263006;645.7062036773303;646.5958775765147;647.2459584583954;647.5758378262245;647.6891092275687;14422.27888605576;14457;14477.131372117707;14487.058341207789;14490.565283041526;13233;13602.727945441135;13605.31973401326;13625.523106691317;14260.500882469063;11275.60535381266;11316.151288653384;11425.371604561746;11429.371384573846;11507.942460287728;3918.1771827916173;3921.29416704993;3940.960590394088;4014.2172276406113;4043.413705012786;51975.48024519744;52079.21881171785;52315.476845231824;52459.73770131163;52763.73618131923;10251.48742562869;10658.62694805678;10730.678079657622;10821.080208182393;10877.238593298393;19597;19677.606447870963;19682.803171968382;19685.803141968685;19687.40937771869;8312.25189732927;8373.371997100241;8394.11861754507;8394.664213431395;8504.192101750325;4660.487346391894;4680.063987202573;4749.64377671676;4771.355866957986;4792;3456.1705190754037;3568.678818906311;3579.46308053794;3582.2119133790525;3583.0325812030605;588.841012926516;597.602594274811;617.5800455690083;619.4208415131866;667.1094089390717;706.4913262451028;738.1732459645232;746.787165657785;767.0258771360452;781.5662307419436;8543.914560854311;8987.820243595223;9183.104759250791;9185.311101667401;9297.349185556946;705.1855107351017;711.3064761857252;730.3974221267475;733.2557454184008;735.7755884455186;4079.7783380345213;4321.524632290446;4664.253719404946;4665.533446655308;4692.671512994126;50938;52877.471225287256;52985.735071324394;56408;57288;49489;50063.24905126426;50292.74853625709;50822.49177508252;51176.48823511717;45192.096158077315;45214;45523.31715024277;46223.5377646226;46741;8573.271271941954;8848.557572121497;8862.778430539289;8870.42342247752;8884.156005179497;31902.840485797424;32040.67959320377;32212.677873221906;32258.83870580632;32478.837605812765;40471;43054;43307.56692433036;43626.56373436225;44360.334594981745;11682.4742886572;11757.529698812294;11872.82190767122;12053.63839084829;12089.516419343128;12858.614241572768;12895.290759007969;13145.474181033034;13405.798913016117;13984.300784960915;9493.952530237304;11541.942290288494;12347.814782778445;12360.75278494443;12521.749565008831;12362.567310144103;12482.188657737219;12511.749765004466;12672.493100275886;13175.670608234488;12360.072994525266;12551.811722823983;12649.620511384674;13126.934365328112;13517.256550889795;10517.368957862553;10582.365058096539;10677.199210059121;10892.891071089187;10898.836517452402;10659.307145035547;10705.785884282115;10760.569577216824;10773.353598784099;10894.704808277744 01:21:02 INFO - PROCESS | 3474 | __end_tp_report 01:21:02 INFO - PROCESS | 3474 | __start_cc_report 01:21:02 INFO - PROCESS | 3474 | _x_x_mozilla_cycle_collect,818 01:21:02 INFO - PROCESS | 3474 | __end_cc_report 01:21:02 INFO - PROCESS | 3474 | __startTimestamp1460276462465__endTimestamp 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | ------- Summary: start ------- 01:21:02 INFO - PROCESS | 3474 | Number of tests: 6 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#0] dojo.html Cycles:165 Average:5352.77 Median:5532.50 stddev:607.68 (11.0%) stddev-sans-first:583.58 01:21:02 INFO - PROCESS | 3474 | Values: 3112.8 3168.4 3181.1 3214.7 3235.8 5368.1 5376.2 5381.1 5468.0 5478.6 5418.2 5464.0 5464.5 5529.3 5532.5 4807.8 4822.9 4837.5 4870.4 5021.1 4919.4 4941.8 4982.2 4982.6 4999.5 4778.1 4898.1 4905.5 4942.4 4959.8 4853.5 4860.2 4861.2 4872.0 4902.6 4819.4 4819.9 4842.7 4845.0 4870.9 5314.9 5348.6 5371.2 5395.6 5407.8 5707.3 5726.6 5727.9 5731.5 5733.1 5712.3 5769.4 5771.5 5785.3 5788.0 5479.5 5479.6 5484.7 5528.4 5528.6 5956.5 5964.7 5968.8 5969.5 5973.4 5536.3 5657.5 5722.1 5725.5 5733.6 5770.0 5772.0 5774.3 5776.0 5780.1 5710.7 5733.5 5737.1 5738.1 5739.7 5680.1 5722.0 5798.4 5839.5 5855.1 4345.5 4346.1 4346.3 4349.7 4379.5 3896.3 3902.3 3916.4 3945.2 3946.8 5213.5 5357.4 5359.2 5400.0 5458.1 5738.9 5740.4 5773.1 5784.2 5790.0 5423.9 5430.2 5432.9 5437.9 5441.2 4892.6 4921.2 4961.7 5000.4 5003.2 5887.0 5907.7 5912.1 5912.7 5912.9 5657.9 5728.6 5734.6 5739.9 5740.7 6024.8 6075.8 6084.5 6119.1 6125.4 5692.1 5727.7 5731.9 5732.6 5744.3 5723.8 5735.8 5835.0 5836.9 5840.2 5604.6 5610.8 5611.5 5620.4 5654.8 5516.0 5546.9 5550.4 5577.8 5596.7 5419.7 5448.5 5471.8 5497.3 5552.9 5616.6 5620.7 5621.4 5630.2 5666.3 5515.4 5515.6 5525.8 5537.6 5543.1 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#1] ext.html Cycles:180 Average:47795.37 Median:18584.73 stddev:87890.60 (472.9%) stddev-sans-first:88065.71 01:21:02 INFO - PROCESS | 3474 | Values: 595.7 656.3 657.1 664.2 668.0 28150.3 28956.4 35700.5 36471.3 36489.1 38987.8 39679.6 39743.8 39760.2 39861.0 8534.0 8734.6 8744.0 8751.7 8752.3 7869.6 10215.5 10556.7 10571.7 10599.4 10288.3 10414.2 10432.9 10437.1 10440.5 7936.4 10275.0 10279.9 10304.6 10383.6 10070.8 10225.4 10227.6 10228.9 10235.9 35917.8 36554.5 36599.6 36615.3 36683.6 3375.5 3527.9 3579.6 3665.9 3720.6 28533.3 30948.1 31202.0 31429.0 32516.5 4318.9 4356.7 4363.1 4367.0 4421.7 212957.0 276043.0 278506.0 278970.0 279030.0 35201.5 58976.1 59335.7 59357.7 59550.0 33794.0 33835.2 33987.2 33990.5 34045.3 14150.6 14414.9 14418.8 14419.3 14421.9 11819.6 11928.3 11929.5 11934.5 11944.2 8458.9 8635.3 8662.2 8667.4 8711.2 3344.9 3352.3 3369.8 3371.2 3392.3 966.6 1040.3 1045.8 1123.6 1174.1 30587.5 30959.4 31031.4 31551.2 31624.0 1102.9 1105.8 1147.7 1173.2 1195.8 15959.3 16913.7 16918.2 16962.7 17141.7 433085.0 436736.0 437989.0 439434.0 441154.0 55737.0 56709.4 56726.4 56741.7 56881.4 1336.3 1349.9 1379.8 1380.5 1407.4 29460.3 30547.7 31321.5 31589.2 31710.5 44180.6 44812.4 44814.1 44819.0 44886.8 262040.0 263803.0 264266.0 265007.0 266864.0 25158.0 27726.7 28499.7 28503.4 28751.6 40292.0 41272.4 41656.6 41747.0 42098.2 38236.4 38263.8 38543.2 38712.8 38847.6 36880.4 37840.4 38210.0 38789.4 38890.0 38579.0 38888.2 39001.6 39395.8 39462.4 32764.5 33718.2 34103.1 34293.7 34340.8 26228.5 26368.5 26653.0 26688.2 26692.1 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#2] jquery.html Cycles:180 Average:26629.17 Median:2279.27 stddev:76672.51 (3363.9%) stddev-sans-first:76862.28 01:21:02 INFO - PROCESS | 3474 | Values: 389.9 401.5 405.7 407.2 410.2 17762.8 17993.5 18205.5 18410.3 18410.4 16668.7 16734.4 17533.1 17708.0 17739.9 5482.3 5592.9 5627.3 5641.7 5691.7 5393.0 5606.7 5615.3 5644.2 5652.7 5478.6 5575.5 5576.7 5583.5 5586.0 5485.3 5592.1 5613.9 5632.5 5635.4 4853.7 5000.0 5027.0 5037.4 5039.8 18937.8 21658.4 21874.5 21964.3 22056.1 2226.0 2279.0 2279.5 2307.1 2371.6 12068.4 13135.9 13151.3 13613.9 14026.4 1697.4 1733.2 1861.1 1890.5 1938.6 72858.8 76173.2 76378.6 77373.6 78382.6 9881.5 9911.3 10160.3 10354.9 10518.2 14397.5 14427.4 14490.3 14493.2 14505.3 7765.0 7777.1 7803.4 7888.6 7929.6 7306.3 7362.9 7492.7 7492.9 7523.1 6199.5 6323.6 6330.5 6386.9 6413.1 1811.5 1882.9 1892.3 1898.6 1899.2 899.8 1029.4 1040.6 1094.5 1141.6 18082.3 18143.6 18203.2 18417.6 18542.9 994.1 999.7 1002.9 1017.8 1055.6 10215.3 10703.8 10787.6 10789.9 10809.4 459858.0 464822.0 469637.0 470230.3 474106.0 61218.7 75623.0 75866.0 77111.0 79066.2 1048.1 1088.4 1115.9 1120.9 1124.4 12670.4 15607.4 15710.5 15823.1 16132.2 30780.2 31364.0 31908.7 32238.5 32259.2 37245.6 38900.8 39605.4 39790.6 40383.8 8031.5 8138.3 8166.7 8316.6 8537.8 12415.0 12696.5 12722.6 12819.2 12872.9 10385.7 10770.4 10963.3 11015.6 11154.2 10561.4 10676.5 10715.4 10875.7 11003.9 11031.7 11073.4 11392.1 11447.4 11522.9 8395.0 8417.6 8453.2 8522.2 8588.0 8519.5 10848.8 10927.5 11111.3 11128.7 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#3] mootools.html Cycles:180 Average:5899.91 Median:5178.47 stddev:3143.85 (60.7%) stddev-sans-first:3134.43 01:21:02 INFO - PROCESS | 3474 | Values: 1394.0 1534.2 1568.0 1741.7 1853.3 7788.3 8028.7 8036.0 8043.7 8045.7 7857.6 7933.7 8004.6 8008.3 8014.8 2025.3 2281.1 2283.7 2301.9 2345.3 2398.1 2417.1 2420.1 2420.6 2422.1 2304.9 2352.8 2353.1 2354.7 2354.9 1911.4 2267.8 2331.5 2333.8 2334.5 2254.4 2257.9 2260.4 2264.9 2299.8 8304.3 8311.2 8374.5 8383.7 8388.4 5009.4 5153.3 5170.0 5186.9 5235.5 3234.8 3275.5 3304.0 3353.4 3365.7 1121.4 1124.7 1133.4 1138.8 1154.1 11969.3 11988.2 11988.2 11996.4 12028.3 4390.7 4531.9 4607.7 4610.6 4757.8 9985.3 10005.1 10011.1 10015.7 10025.1 4705.6 5302.1 5328.4 5347.3 5361.1 4639.2 4691.5 4712.7 4732.2 4738.4 3905.6 3964.6 3972.0 3995.9 4012.3 1245.5 1255.6 1267.7 1272.4 1287.2 1364.9 1380.9 1410.0 1420.2 1431.2 8079.4 8174.4 8185.7 8191.4 8200.9 470.1 471.2 479.8 480.0 497.2 6266.9 6286.6 6332.5 6361.9 6383.7 9836.6 10156.4 10235.8 10258.4 10275.9 9947.8 10048.0 10075.2 10092.9 10140.8 7692.6 7720.3 7749.5 7757.7 7827.3 7712.3 7722.7 8113.9 8124.9 8125.8 9395.3 9396.2 9407.9 9551.4 9578.2 9495.6 9581.7 9802.7 9831.7 9877.5 7029.1 7325.2 7398.3 7516.7 7554.1 8080.4 8098.7 8107.4 8152.9 8163.1 7101.8 7252.9 7304.8 7341.3 7348.6 7383.5 7426.4 7572.2 7597.7 7735.6 7576.3 7592.2 7659.8 7689.6 7689.9 7032.6 7073.0 7148.8 7205.8 7208.8 7013.4 7076.0 7081.3 7083.0 7185.2 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#4] prototype.html Cycles:180 Average:5046.69 Median:5712.44 stddev:1502.45 (26.3%) stddev-sans-first:1464.61 01:21:02 INFO - PROCESS | 3474 | Values: 343.3 343.9 345.2 346.3 354.8 5597.4 5654.3 5678.5 5711.9 5713.0 5599.6 5603.8 5612.7 5613.4 5633.9 4322.2 4400.9 4408.1 4426.1 4426.9 4402.5 4402.7 4414.8 4415.0 4438.9 4152.3 4221.6 4377.9 4382.3 4399.8 4368.6 4372.6 4384.0 4397.1 4420.9 3893.4 3894.5 3900.5 3920.1 3925.3 5207.5 5244.7 5438.1 5449.0 5467.5 5044.5 5091.8 5100.7 5104.1 5106.3 5933.4 5951.5 5961.1 5971.4 5980.0 3998.9 4213.9 4222.6 4231.1 4244.1 6123.7 6177.5 6203.2 6204.2 6206.0 4333.6 4334.4 4335.3 4337.7 4346.6 4183.4 4408.7 4411.7 4425.3 4431.4 5043.5 5050.4 5053.2 5062.9 5088.8 5741.9 5925.5 6063.3 6071.2 6073.6 1515.6 1520.8 1528.0 1533.7 1539.5 1002.4 1027.7 1036.1 1037.4 1049.4 5786.4 5802.9 5829.2 5843.8 5849.4 5946.9 6171.5 6173.0 6173.8 6189.0 5636.0 5878.8 5888.6 5889.5 5909.6 3285.2 3320.0 3322.2 3332.6 3342.6 6339.9 6443.6 6447.6 6450.4 6468.3 6333.7 6365.9 6375.6 6376.9 6383.9 6191.7 6419.0 6446.6 6451.1 6458.2 6172.2 6182.8 6208.0 6221.0 6230.6 6012.6 6085.5 6098.6 6143.0 6183.4 6354.5 6443.7 6447.7 6454.2 6460.9 4373.1 4376.3 4376.5 4392.1 4394.1 6125.3 6195.8 6257.6 6257.8 6275.7 6040.8 6060.5 6065.7 6069.2 6069.6 5956.3 5976.9 6051.6 6087.7 6088.4 5882.2 5920.8 5924.4 5926.2 5926.4 6071.9 6075.9 6095.6 6104.4 6107.8 5659.8 5730.3 5796.0 5874.7 5985.1 01:21:02 INFO - PROCESS | 3474 | 01:21:02 INFO - PROCESS | 3474 | [#5] yui.html Cycles:180 Average:14076.80 Median:44776.22 stddev:15607.69 (34.9%) stddev-sans-first:15619.42 01:21:02 INFO - PROCESS | 3474 | Values: 756.8 763.3 832.2 850.0 869.7 13034.8 13064.5 13204.6 13212.8 13252.0 12206.6 12209.1 12225.8 12240.1 12835.2 702.6 836.5 838.2 860.1 864.8 847.7 848.9 850.4 855.0 855.5 888.4 896.5 897.7 898.2 898.2 726.2 858.6 882.4 883.3 883.5 645.7 646.6 647.2 647.6 647.7 14422.3 14457.0 14477.1 14487.1 14490.6 13233.0 13602.7 13605.3 13625.5 14260.5 11275.6 11316.2 11425.4 11429.4 11507.9 3918.2 3921.3 3941.0 4014.2 4043.4 51975.5 52079.2 52315.5 52459.7 52763.7 10251.5 10658.6 10730.7 10821.1 10877.2 19597.0 19677.6 19682.8 19685.8 19687.4 8312.3 8373.4 8394.1 8394.7 8504.2 4660.5 4680.1 4749.6 4771.4 4792.0 3456.2 3568.7 3579.5 3582.2 3583.0 588.8 597.6 617.6 619.4 667.1 706.5 738.2 746.8 767.0 781.6 8543.9 8987.8 9183.1 9185.3 9297.3 705.2 711.3 730.4 733.3 735.8 4079.8 4321.5 4664.3 4665.5 4692.7 50938.0 52877.5 52985.7 56408.0 57288.0 49489.0 50063.2 50292.7 50822.5 51176.5 45192.1 45214.0 45523.3 46223.5 46741.0 8573.3 8848.6 8862.8 8870.4 8884.2 31902.8 32040.7 32212.7 32258.8 32478.8 40471.0 43054.0 43307.6 43626.6 44360.3 11682.5 11757.5 11872.8 12053.6 12089.5 12858.6 12895.3 13145.5 13405.8 13984.3 9494.0 11541.9 12347.8 12360.8 12521.7 12362.6 12482.2 12511.7 12672.5 13175.7 12360.1 12551.8 12649.6 13126.9 13517.3 10517.4 10582.4 10677.2 10892.9 10898.8 10659.3 10705.8 10760.6 10773.4 10894.7 01:21:02 INFO - PROCESS | 3474 | -------- Summary: end -------- 01:21:02 INFO - PROCESS | 3474 | 01:21:03 INFO - TEST-INFO | 3474: exit 0 01:21:03 INFO - TEST-OK | dromaeo_css | took 1112966ms 01:21:03 INFO - TEST-START | kraken 01:21:03 INFO - operating with platform_type : linux_ 01:21:03 INFO - Initialising browser for kraken test... 01:21:03 INFO - TEST-INFO | started process 3663 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Us6w5/profile http://localhost:41834/getInfo.html) 01:21:07 INFO - PROCESS | 3663 | __metrics Screen width/height:1600/1200 01:21:07 INFO - PROCESS | 3663 | colorDepth:24 01:21:07 INFO - PROCESS | 3663 | Browser inner width/height: 1024/697 01:21:07 INFO - PROCESS | 3663 | __metrics 01:21:08 ERROR - PROCESS | 3663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:21:09 INFO - TEST-INFO | 3663: exit 0 01:21:09 INFO - Browser initialized. 01:21:09 INFO - Running cycle 1/1 for kraken test... 01:21:09 INFO - TEST-INFO | started process 3743 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Us6w5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:21:21 INFO - PROCESS | 3743 | RSS: Main: 153063424 01:21:21 INFO - PROCESS | 3743 | 01:21:23 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41834/tests/kraken/driver.html?testName=audio-beat-detection) 01:21:24 INFO - PROCESS | 3743 | RSS: Main: 207835136 01:21:24 INFO - PROCESS | 3743 | 01:21:27 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41834/tests/kraken/driver.html?testName=audio-dft) 01:21:28 INFO - PROCESS | 3743 | RSS: Main: 194187264 01:21:28 INFO - PROCESS | 3743 | 01:21:31 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41834/tests/kraken/driver.html?testName=audio-fft) 01:21:31 INFO - PROCESS | 3743 | RSS: Main: 262819840 01:21:31 INFO - PROCESS | 3743 | 01:21:33 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41834/tests/kraken/driver.html?testName=audio-oscillator) 01:21:34 INFO - PROCESS | 3743 | RSS: Main: 172277760 01:21:34 INFO - PROCESS | 3743 | 01:21:36 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:21:37 INFO - PROCESS | 3743 | RSS: Main: 176365568 01:21:37 INFO - PROCESS | 3743 | 01:21:40 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41834/tests/kraken/driver.html?testName=imaging-darkroom) 01:21:40 INFO - PROCESS | 3743 | RSS: Main: 213229568 01:21:40 INFO - PROCESS | 3743 | 01:21:44 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41834/tests/kraken/driver.html?testName=imaging-desaturate) 01:21:44 INFO - PROCESS | 3743 | RSS: Main: 213655552 01:21:44 INFO - PROCESS | 3743 | 01:21:47 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41834/tests/kraken/driver.html?testName=json-parse-financial) 01:21:48 INFO - PROCESS | 3743 | RSS: Main: 213417984 01:21:48 INFO - PROCESS | 3743 | 01:21:49 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:21:50 INFO - PROCESS | 3743 | RSS: Main: 201674752 01:21:50 INFO - PROCESS | 3743 | 01:21:51 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:21:52 INFO - PROCESS | 3743 | RSS: Main: 203927552 01:21:52 INFO - PROCESS | 3743 | 01:21:54 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:21:55 INFO - PROCESS | 3743 | RSS: Main: 218886144 01:21:55 INFO - PROCESS | 3743 | 01:21:57 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:21:58 INFO - PROCESS | 3743 | RSS: Main: 222687232 01:21:58 INFO - PROCESS | 3743 | 01:22:01 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:22:01 INFO - PROCESS | 3743 | RSS: Main: 218316800 01:22:01 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | Cycle 1(1): loaded http://localhost:41834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41834/tests/kraken/driver.html?testName=ai-astar) 01:22:03 INFO - PROCESS | 3743 | RSS: Main: 281632768 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | __start_tp_report 01:22:03 INFO - PROCESS | 3743 | _x_x_mozilla_page_load 01:22:03 INFO - PROCESS | 3743 | _x_x_mozilla_page_load_details 01:22:03 INFO - PROCESS | 3743 | |i|pagename|runs| 01:22:03 INFO - PROCESS | 3743 | |0;ai-astar;110;111;106;110;110;110;98;110;110;109 01:22:03 INFO - PROCESS | 3743 | |1;audio-beat-detection;154;127;151;174;125;156;158;128;181;124 01:22:03 INFO - PROCESS | 3743 | |2;audio-dft;162;161;161;162;158;160;160;161;161;162 01:22:03 INFO - PROCESS | 3743 | |3;audio-fft;75;76;96;114;74;73;73;125;101;73 01:22:03 INFO - PROCESS | 3743 | |4;audio-oscillator;94;93;147;94;93;94;149;93;93;154 01:22:03 INFO - PROCESS | 3743 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;116;117 01:22:03 INFO - PROCESS | 3743 | |6;imaging-darkroom;145;145;145;145;145;146;145;145;145;145 01:22:03 INFO - PROCESS | 3743 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 01:22:03 INFO - PROCESS | 3743 | |8;json-parse-financial;56;58;57;56;57;56;57;73;57;53 01:22:03 INFO - PROCESS | 3743 | |9;json-stringify-tinderbox;61;61;60;61;62;61;60;60;61;61 01:22:03 INFO - PROCESS | 3743 | |10;stanford-crypto-aes;79;79;78;77;79;78;79;79;79;80 01:22:03 INFO - PROCESS | 3743 | |11;stanford-crypto-ccm;136;127;129;126;124;124;126;127;161;129 01:22:03 INFO - PROCESS | 3743 | |12;stanford-crypto-pbkdf2;165;169;168;168;162;165;172;165;163;161 01:22:03 INFO - PROCESS | 3743 | |13;stanford-crypto-sha256-iterative;67;69;67;67;69;68;67;67;75;67 01:22:03 INFO - PROCESS | 3743 | __end_tp_report 01:22:03 INFO - PROCESS | 3743 | __start_cc_report 01:22:03 INFO - PROCESS | 3743 | _x_x_mozilla_cycle_collect,1612 01:22:03 INFO - PROCESS | 3743 | __end_cc_report 01:22:03 INFO - PROCESS | 3743 | __startTimestamp1460276523688__endTimestamp 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | ------- Summary: start ------- 01:22:03 INFO - PROCESS | 3743 | Number of tests: 14 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.89 (3.5%) stddev-sans-first:4.09 01:22:03 INFO - PROCESS | 3743 | Values: 110.0 111.0 106.0 110.0 110.0 110.0 98.0 110.0 110.0 109.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.00 stddev:20.87 (13.5%) stddev-sans-first:22.01 01:22:03 INFO - PROCESS | 3743 | Values: 154.0 127.0 151.0 174.0 125.0 156.0 158.0 128.0 181.0 124.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 01:22:03 INFO - PROCESS | 3743 | Values: 162.0 161.0 161.0 162.0 158.0 160.0 160.0 161.0 161.0 162.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#3] audio-fft Cycles:10 Average:88.00 Median:73.50 stddev:19.61 (26.7%) stddev-sans-first:20.23 01:22:03 INFO - PROCESS | 3743 | Values: 75.0 76.0 96.0 114.0 74.0 73.0 73.0 125.0 101.0 73.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:93.00 stddev:27.38 (29.4%) stddev-sans-first:28.39 01:22:03 INFO - PROCESS | 3743 | Values: 94.0 93.0 147.0 94.0 93.0 94.0 149.0 93.0 93.0 154.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:22:03 INFO - PROCESS | 3743 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 01:22:03 INFO - PROCESS | 3743 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 01:22:03 INFO - PROCESS | 3743 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:5.44 (9.5%) stddev-sans-first:5.72 01:22:03 INFO - PROCESS | 3743 | Values: 56.0 58.0 57.0 56.0 57.0 56.0 57.0 73.0 57.0 53.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:22:03 INFO - PROCESS | 3743 | Values: 61.0 61.0 60.0 61.0 62.0 61.0 60.0 60.0 61.0 61.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 01:22:03 INFO - PROCESS | 3743 | Values: 79.0 79.0 78.0 77.0 79.0 78.0 79.0 79.0 79.0 80.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:128.00 stddev:11.12 (8.7%) stddev-sans-first:11.64 01:22:03 INFO - PROCESS | 3743 | Values: 136.0 127.0 129.0 126.0 124.0 124.0 126.0 127.0 161.0 129.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.50 stddev:3.43 (2.1%) stddev-sans-first:3.62 01:22:03 INFO - PROCESS | 3743 | Values: 165.0 169.0 168.0 168.0 162.0 165.0 172.0 165.0 163.0 161.0 01:22:03 INFO - PROCESS | 3743 | 01:22:03 INFO - PROCESS | 3743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.50 stddev:2.50 (3.7%) stddev-sans-first:2.60 01:22:03 INFO - PROCESS | 3743 | Values: 67.0 69.0 67.0 67.0 69.0 68.0 67.0 67.0 75.0 67.0 01:22:03 INFO - PROCESS | 3743 | -------- Summary: end -------- 01:22:03 INFO - PROCESS | 3743 | 01:22:04 INFO - TEST-INFO | 3743: exit 0 01:22:04 INFO - TEST-OK | kraken | took 61511ms 01:22:04 INFO - SUITE-END | took 1174s 01:22:04 INFO - Completed test suite (00:19:34) 01:22:04 INFO - javascript benchmark 01:22:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.828794416307, 3168.4455220336436, 3181.061586831886, 3214.710676039156, 3235.7573182011347, 5368.114261146916, 5376.247325374451, 5381.112116500777, 5467.972660136694, 5478.58910581706, 5418.214358917954, 5464.0, 5464.480874316933, 5529.281193444846, 5532.502074813266, 4807.831725889595, 4822.927656085161, 4837.516248375152, 4870.415550133971, 5021.071101846152, 4919.360483137187, 4941.802327906879, 4982.202847544394, 4982.57648099912, 4999.525045120708, 4778.092162489116, 4898.093852637274, 4905.533974272438, 4942.382202224722, 4959.8264060758065, 4853.490383509751, 4860.246661767432, 4861.197902346109, 4871.975640121812, 4902.558769710743, 4819.42166939966, 4819.927701084486, 4842.733649649268, 4845.0, 4870.853874383739, 5314.92027619586, 5348.625596208267, 5371.248025276464, 5395.595330350239, 5407.783688652449, 5707.286589176353, 5726.570507211975, 5727.856803579903, 5731.484166425042, 5733.082706766939, 5712.343080545749, 5769.365369809318, 5771.538276937835, 5785.334686511063, 5788.016037273674, 5479.53423958968, 5479.561635069185, 5484.670919744788, 5528.391876893538, 5528.612997090206, 5956.52347812174, 5964.7315870785915, 5968.791092311748, 5969.522438204933, 5973.372795856372, 5536.280283563111, 5657.547396208293, 5722.141678748221, 5725.541956643458, 5733.627314224562, 5769.9711501442225, 5772.0, 5774.2782152230975, 5775.971120144456, 5780.104083867007, 5710.7430165642645, 5733.512651424676, 5737.053386191315, 5738.081906894877, 5739.655620662774, 5680.091185410314, 5721.971390143106, 5798.449147330997, 5839.5036421904615, 5855.092460668603, 4345.478542574911, 4346.087321662423, 4346.348047792856, 4349.695521313478, 4379.4525684289465, 3896.337622604164, 3902.31709450845, 3916.373380259145, 3945.2306800174265, 3946.782926939046, 5213.478652134832, 5357.383900851374, 5359.22291267764, 5400.0, 5458.072127738294, 5738.856528586735, 5740.368559458456, 5773.076307790733, 5784.248047753765, 5790.044642634002, 5423.891522169613, 5430.185472179205, 5432.945670543244, 5437.864053398617, 5441.238226648273, 4892.633052521075, 4921.212605983025, 4961.727105009187, 5000.399952005782, 5003.174476211457, 5886.970565147147, 5907.675077870758, 5912.142739302777, 5912.674802885796, 5912.940870591325, 5657.886842263049, 5728.570357223141, 5734.569907256889, 5739.942600573941, 5740.712964351849, 6024.849378765566, 6075.848103797441, 6084.513238940785, 6119.082137679384, 6125.387461253839, 5692.1461780733225, 5727.6849773262875, 5731.942680573307, 5732.59871808986, 5744.310682718101, 5723.828285151452, 5735.799247026334, 5835.037218859011, 5836.854078647898, 5840.182374467663, 5604.551635869039, 5610.7755689773585, 5611.494965453129, 5620.4098569649595, 5654.773809047757, 5515.972420137874, 5546.916796247979, 5550.361708403424, 5577.832665020056, 5596.664200148004, 5419.674819510842, 5448.5368743655645, 5471.781128754806, 5497.285352904097, 5552.861178470571, 5616.5787565931905, 5620.747066382104, 5621.353544342453, 5630.211770352236, 5666.291713535808, 5515.393306736336, 5515.558755299486, 5525.751341189576, 5537.5569954404355, 5543.113101903838], "value": 5312.108999995143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.65749693926, 656.3436563436563, 657.1424291299853, 664.1532046640534, 667.9779936696852, 28150.29624259392, 28956.42087158258, 35700.46449303256, 36471.27057458849, 36489.087772805695, 38987.80506097466, 39679.60320396795, 39743.80128099355, 39760.204795904065, 39861.0, 8533.95733021334, 8734.563271836414, 8743.95628021859, 8751.737447876574, 8752.256058235025, 7869.606519674022, 10215.540300686449, 10556.736081597983, 10571.682849514527, 10599.364038157697, 10288.331258468213, 10414.16686665065, 10432.895671043269, 10437.11284540815, 10440.477976101165, 7936.36509079278, 10275.0, 10279.897201028007, 10304.587816487332, 10383.584656613726, 10070.798584028278, 10225.386476811414, 10227.590896364136, 10228.89771102287, 10235.948820255926, 35917.82041089804, 36554.451683224506, 36599.634003660154, 36615.26769464622, 36683.63316366829, 3375.4599264117624, 3527.9139853393276, 3579.552555930509, 3665.945010824813, 3720.6465385788306, 28533.28666783347, 30948.0715578533, 31202.0, 31429.0, 32516.512252316235, 4318.892027699301, 4356.6732495063, 4363.083752411997, 4367.0, 4421.712588681726, 212957.0, 276043.0, 278506.0, 278970.0, 279030.0, 35201.47197792035, 58976.1153582688, 59335.70332148312, 59357.70321148367, 59550.0, 33794.0, 33835.15412114717, 33987.15032124217, 33990.49014264788, 34045.319093618484, 14150.575482735534, 14414.927925360305, 14418.783718244234, 14419.279036048365, 14421.855781442051, 11819.645410637695, 11928.34394108315, 11929.463174157183, 11934.522619095313, 11944.163908526494, 8458.87311690325, 8635.309175265964, 8662.177093176264, 8667.4366166199, 8711.172438618449, 3344.9331013379597, 3352.2792599591203, 3369.79781213128, 3371.224618337796, 3392.3215356928713, 966.5891995901713, 1040.2977989856815, 1045.8274384726435, 1123.5730422439585, 1174.0724827386439, 30587.541186882216, 30959.380812384075, 31031.379372412426, 31551.21121971969, 31624.0, 1102.8676558812995, 1105.7733164701217, 1147.7360207152235, 1173.1729130962651, 1195.8026925557185, 15959.281832317574, 16913.661726765396, 16918.154092295335, 16962.660746784994, 17141.657166856592, 433085.0, 436736.0, 437989.0, 439434.0, 441154.0, 55737.0, 56709.432905670415, 56726.43273567294, 56741.71629141911, 56881.43118568844, 1336.2784096587927, 1349.8650134986424, 1379.8413182484144, 1380.5306195893243, 1407.429990853706, 29460.263493412836, 30547.687431910996, 31321.530177047818, 31589.21026974252, 31710.524342134424, 44180.55819441893, 44812.41500679873, 44814.10371792481, 44819.0, 44886.77556612196, 262040.0, 263803.0, 264266.0, 265007.0, 266864.0, 25158.0, 27726.722732772414, 28499.715002849705, 28503.437070366203, 28751.5687264687, 40292.0, 41272.38091428691, 41656.58343416527, 41747.0, 42098.158036839704, 38236.42645360266, 38263.80868095642, 38543.22913541769, 38712.80643596764, 38847.6115238844, 36880.44679329866, 37840.43239351467, 38210.0, 38789.41815872708, 38890.0, 38579.0, 38888.222235555695, 39001.6099838998, 39395.80302098471, 39462.40806387964, 32764.50853237251, 33718.15704607405, 34103.147421314665, 34293.65706342905, 34340.82829585836, 26228.4754304909, 26368.472630546898, 26653.0, 26688.19935401941, 26692.065777698463], "value": 18002.84596472767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.94540764292987, 401.4780784979526, 405.6511400195833, 407.21814116895564, 410.220580896297, 17762.822371776296, 17993.460196194133, 18205.453836384928, 18410.263589456423, 18410.44768656941, 16668.74996875048, 16734.41429549966, 17533.12334383279, 17707.989641760898, 17739.91130044348, 5482.314710661178, 5592.86017849555, 5627.324721033461, 5641.661500309974, 5691.686957217351, 5393.0, 5606.747696353674, 5615.326160860703, 5644.238027866227, 5652.689102099383, 5478.58910581708, 5575.498205161534, 5576.749046292926, 5583.5254003409755, 5586.0, 5485.341758988927, 5592.133219351007, 5613.887722245573, 5632.5212356949705, 5635.436456354373, 4853.733044682541, 5000.049990501793, 5027.0, 5037.420696619899, 5039.798408063673, 18937.81062189388, 21658.35024949254, 21874.453138671503, 21964.341069767932, 22056.117755289768, 2226.0, 2278.9886050569808, 2279.5440911817536, 2307.14635584833, 2371.6086845670443, 12068.396580170956, 13135.86864131356, 13151.276679782608, 13613.863861361358, 14026.43894244229, 1697.3719723702309, 1733.2027267456986, 1861.0973677766272, 1890.5179179309325, 1938.5928954919484, 72858.80724535193, 76173.23826761717, 76378.61810690966, 77373.61313193398, 78382.6080869592, 9881.456519891475, 9911.306208565475, 10160.288779785493, 10354.896451035393, 10518.158547316196, 14397.496087637091, 14427.422903083969, 14490.347934342979, 14493.202873841828, 14505.274736263145, 7765.029371328584, 7777.144514103444, 7803.414743894231, 7888.605569721606, 7929.563873986871, 7306.2693730626515, 7362.8527429451115, 7492.700291988368, 7492.850142997218, 7523.059617547807, 6199.535034872402, 6323.5573509854785, 6330.52521060913, 6386.904196437057, 6413.0701048348665, 1811.5471132216946, 1882.868199226041, 1892.2556581424099, 1898.6487499812304, 1899.202335019295, 899.7660608241904, 1029.4183786160795, 1040.6409788622914, 1094.518411898762, 1141.5547936304847, 18082.276708931495, 18143.63712725738, 18203.180856861472, 18417.631647366976, 18542.907285463487, 994.1202036198017, 999.7000899730052, 1002.8595996560488, 1017.7811770469384, 1055.6358056470506, 10215.336003159919, 10703.785924281627, 10787.6224332148, 10789.892101078889, 10809.405482698527, 459858.0, 464822.0, 469637.0, 470230.296649104, 474106.0, 61218.693906530185, 75623.0, 75866.0, 77111.0, 79066.20933790703, 1048.0933992096782, 1088.374184843702, 1115.9274647148072, 1120.9047230985457, 1124.4096849154096, 12670.366481676063, 15607.375704971673, 15710.528684139494, 15823.129727865078, 16132.193390330202, 30780.23049423782, 31364.0, 31908.680913190572, 32238.516422253215, 32259.193520161243, 37245.627543724215, 38900.80549597234, 39605.40591891181, 39790.60209397869, 40383.79808100941, 8031.518108913484, 8138.308243799106, 8166.714165004197, 8316.584170791315, 8537.786555336166, 12415.0, 12696.492140314283, 12722.61832145037, 12819.230846149261, 12872.935635321763, 10385.688429347132, 10770.353778773298, 10963.287386319864, 11015.614453494089, 11154.219204655921, 10561.366318020944, 10676.46617669129, 10715.41065241388, 10875.728106797076, 11003.889961100607, 11031.669049928514, 11073.390963497084, 11392.088632909514, 11447.427628618369, 11522.942385288019, 8394.959064674806, 8417.62120704582, 8453.196946290092, 8522.232999030117, 8588.0, 8519.488830669932, 10848.837267441153, 10927.453627318444, 11111.333320000826, 11128.666140015812], "value": 8804.192187370498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.9721205575895, 1534.248218372997, 1568.0278227498948, 1741.7213245880653, 1853.3235369090287, 7788.260115289046, 8028.678852845894, 8036.0, 8043.718469853557, 8045.718399856006, 7857.567833769141, 7933.722319718811, 8004.559749213791, 8008.27925486706, 8014.799630009253, 2025.250657256817, 2281.0761641535205, 2283.691701620285, 2301.8618882867, 2345.331580499558, 2398.0767404549288, 2417.069428270111, 2420.104561312317, 2420.5884999550117, 2422.1038215860067, 2304.8617082975074, 2352.811775058, 2353.0705371378294, 2354.6585745066955, 2354.8822558872075, 1911.4170178095676, 2267.807236384901, 2331.48707284398, 2333.8132949364012, 2334.5447637710654, 2254.4363909022745, 2257.887105644711, 2260.378395941113, 2264.92072777452, 2299.8275129365366, 8304.335653147733, 8311.210435008725, 8374.49753014821, 8383.664653413856, 8388.370872184549, 5009.398872135331, 5153.330067091254, 5170.017696637627, 5186.92219616706, 5235.502627250406, 3234.75739319552, 3275.5414242006136, 3304.0, 3353.3628610563915, 3365.7139143172617, 1121.3552207480732, 1124.707576030238, 1133.4162906103363, 1138.7623320175894, 1154.105568184655, 11969.341686207255, 11988.160828741991, 11988.160828741991, 11996.400179991053, 12028.338441385808, 4390.714603550759, 4531.886702832456, 4607.723536587815, 4610.585047345755, 4757.833475828329, 9985.251106167067, 10005.14956228714, 10011.099001089937, 10015.69952901414, 10025.147862431775, 4705.6000239979985, 5302.09864323066, 5328.387235467893, 5347.25138480613, 5361.08861493547, 4639.188142075123, 4691.507391723888, 4712.740799256074, 4732.171869922819, 4738.384010078667, 3905.628965248297, 3964.6431821136234, 3972.0467087899274, 3995.92008159841, 4012.297847876668, 1245.5391505143155, 1255.604484587352, 1267.6704056945262, 1272.37017676249, 1287.2083668543778, 1364.8976326775532, 1380.882624976868, 1409.971800563983, 1420.218879616207, 1431.2485944878813, 8079.4344395892895, 8174.386920980831, 8185.713500027589, 8191.426600137933, 8200.876986845202, 470.0763000703565, 471.2342443529265, 479.7505297245413, 479.9616030717534, 497.17717178070353, 6266.874662506724, 6286.622802631857, 6332.461740751995, 6361.9045714314325, 6383.744650214032, 9836.60653573849, 10156.441395723159, 10235.846462303072, 10258.384496930208, 10275.948620257, 9947.751306217258, 10048.0, 10075.193984481224, 10092.949535252423, 10140.797184056426, 7692.615369231516, 7720.305172534387, 7749.496282741717, 7757.650905709256, 7827.256410641094, 7712.267334603203, 7722.652480638272, 8113.878291825509, 8124.918750812652, 8125.8374832504205, 9395.2953528487, 9396.201322887631, 9407.85888211691, 9551.379160354554, 9578.185854202471, 9495.620175193191, 9581.664641737505, 9802.65690700822, 9831.655892043744, 9877.456739879375, 7029.05107810439, 7325.230850760593, 7398.297161769623, 7516.736914207976, 7554.093508778982, 8080.393970452122, 8098.7165449209, 8107.391945604221, 8152.918470815216, 8163.102058773649, 7101.751438699621, 7252.854942901218, 7304.780856574099, 7341.302576255247, 7348.595827229554, 7383.520071195355, 7426.368758655575, 7572.20491848348, 7597.6581053851605, 7735.574543400167, 7576.3181313679825, 7592.16486186508, 7659.808504787425, 7689.577073260801, 7689.92310076892, 7032.578045317297, 7073.045138906182, 7148.785536433916, 7205.819854503469, 7208.783736487913, 7013.403860671696, 7075.964620176866, 7081.291870812877, 7082.964585177041, 7185.173705023989], "value": 4722.049083179228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.272262802858, 343.9415299399102, 345.1715881883481, 346.2745548076779, 354.83500172419804, 5597.412271711468, 5654.349749778777, 5678.466813960238, 5711.885762284752, 5713.0, 5599.580031497633, 5603.831885043445, 5612.719364031792, 5613.4386561343845, 5633.929553384864, 4322.222000039991, 4400.921774165334, 4408.074304396081, 4426.100903907945, 4426.933595996046, 4402.471703395597, 4402.713823601472, 4414.823407063714, 4415.011037527589, 4438.866833994985, 4152.335626299792, 4221.6490722968665, 4377.912441751163, 4382.320740285261, 4399.802008909607, 4368.563143685637, 4372.606465418112, 4383.956160438419, 4397.087267038848, 4420.911581768379, 3893.3770596704676, 3894.4547763313158, 3900.4539364488996, 3920.1179734559782, 3925.2934471795065, 5207.4792520748, 5244.685318880841, 5438.129899216106, 5449.0, 5467.480589344006, 5044.52077052683, 5091.847244582668, 5100.719460429675, 5104.116174361474, 5106.310648062501, 5933.406659334032, 5951.49412299955, 5961.105834124916, 5971.4327138921735, 5979.970100149515, 3998.9400158997637, 4213.852515161985, 4222.577742225783, 4231.132617813341, 4244.0663054128045, 6123.6938153092615, 6177.536684748617, 6203.193584833943, 6204.162438070848, 6205.968970155165, 4333.566643335641, 4334.414853994734, 4335.263005289108, 4337.7397356158735, 4346.608805207483, 4183.393407955829, 4408.707472114483, 4411.713238639478, 4425.269830477935, 4431.40176076232, 5043.470435604282, 5050.419201791841, 5053.191489361684, 5062.873428164326, 5088.821891233789, 5741.88516229673, 5925.4520556160405, 6063.272407311063, 6071.180390647206, 6073.5748497604745, 1515.5756388211319, 1520.8251051129262, 1527.9847201528064, 1533.6932613477127, 1539.4765779634977, 1002.4336250018716, 1027.6505987964129, 1036.103770238738, 1037.3827572594294, 1049.4280617063719, 5786.363500014995, 5802.88394232113, 5829.183914252008, 5843.795467158629, 5849.356570777211, 5946.910796338058, 6171.475424588871, 6172.969135154385, 6173.81478555644, 6188.9690551546955, 5635.971820140955, 5878.764849406061, 5888.558358123158, 5889.499392551681, 5909.556783241274, 3285.178705323669, 3319.9502007469905, 3322.186064414234, 3332.5667663204113, 3342.649021852719, 6339.907830415952, 6443.552699305849, 6447.580907241015, 6450.41946224842, 6468.2561505427475, 6333.746650133943, 6365.904511432333, 6375.585586936834, 6376.936230637727, 6383.904241436382, 6191.659458729813, 6418.967905160631, 6446.645434501147, 6451.1290975717675, 6458.160439142881, 6172.197614310111, 6182.783602573888, 6208.0, 6220.968895155495, 6230.563860529719, 6012.579119461596, 6085.53947052713, 6098.573099882966, 6142.969285153725, 6183.350748171557, 6354.491640668828, 6443.743470023301, 6447.742090316522, 6454.225492940689, 6460.903086453613, 4373.125374925091, 4376.321670141133, 4376.49670287921, 4392.12157568494, 4394.1211757649235, 6125.326214116354, 6195.752169913333, 6257.561970662192, 6257.843553911189, 6275.717592708431, 6040.7583696651645, 6060.515158787198, 6065.696715164312, 6069.241344831896, 6069.575129740876, 5956.315023772148, 5976.940230597638, 6051.612580879004, 6087.66517841523, 6088.391160883876, 5882.205902203148, 5920.79277225295, 5924.437178468039, 5926.2295901532525, 5926.377730338252, 6071.939280607314, 6075.878482430238, 6095.634261944298, 6104.4200800923845, 6107.755689772359, 5659.801906933238, 5730.312362516358, 5795.971020144872, 5874.676892770939, 5985.102234664835], "value": 4566.186387068363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.833496630741, 763.2634507700068, 832.1927730101801, 850.0437008365589, 869.7477731457875, 13034.804477932827, 13064.542741004067, 13204.603861884134, 13212.801807972888, 13252.0, 12206.633800985963, 12209.145359824815, 12225.755484890296, 12240.081993850474, 12835.229886206835, 702.6135625406006, 836.5273620404482, 838.2246422059586, 860.1054902900976, 864.7881269089082, 847.7244895408986, 848.8514509960763, 850.421713235, 855.0124606079987, 855.4610595324937, 888.3648191543045, 896.4800415758876, 897.7351681254013, 898.2230370729337, 898.2275243290765, 726.2447055062728, 858.6393714639835, 882.4264228251624, 883.2536506651869, 883.514067263006, 645.7062036773303, 646.5958775765147, 647.2459584583954, 647.5758378262245, 647.6891092275687, 14422.27888605576, 14457.0, 14477.131372117707, 14487.058341207789, 14490.565283041526, 13233.0, 13602.727945441135, 13605.31973401326, 13625.523106691317, 14260.500882469063, 11275.60535381266, 11316.151288653384, 11425.371604561746, 11429.371384573846, 11507.942460287728, 3918.1771827916173, 3921.29416704993, 3940.960590394088, 4014.2172276406113, 4043.413705012786, 51975.48024519744, 52079.21881171785, 52315.476845231824, 52459.73770131163, 52763.73618131923, 10251.48742562869, 10658.62694805678, 10730.678079657622, 10821.080208182393, 10877.238593298393, 19597.0, 19677.606447870963, 19682.803171968382, 19685.803141968685, 19687.40937771869, 8312.25189732927, 8373.371997100241, 8394.11861754507, 8394.664213431395, 8504.192101750325, 4660.487346391894, 4680.063987202573, 4749.64377671676, 4771.355866957986, 4792.0, 3456.1705190754037, 3568.678818906311, 3579.46308053794, 3582.2119133790525, 3583.0325812030605, 588.841012926516, 597.602594274811, 617.5800455690083, 619.4208415131866, 667.1094089390717, 706.4913262451028, 738.1732459645232, 746.787165657785, 767.0258771360452, 781.5662307419436, 8543.914560854311, 8987.820243595223, 9183.104759250791, 9185.311101667401, 9297.349185556946, 705.1855107351017, 711.3064761857252, 730.3974221267475, 733.2557454184008, 735.7755884455186, 4079.7783380345213, 4321.524632290446, 4664.253719404946, 4665.533446655308, 4692.671512994126, 50938.0, 52877.471225287256, 52985.735071324394, 56408.0, 57288.0, 49489.0, 50063.24905126426, 50292.74853625709, 50822.49177508252, 51176.48823511717, 45192.096158077315, 45214.0, 45523.31715024277, 46223.5377646226, 46741.0, 8573.271271941954, 8848.557572121497, 8862.778430539289, 8870.42342247752, 8884.156005179497, 31902.840485797424, 32040.67959320377, 32212.677873221906, 32258.83870580632, 32478.837605812765, 40471.0, 43054.0, 43307.56692433036, 43626.56373436225, 44360.334594981745, 11682.4742886572, 11757.529698812294, 11872.82190767122, 12053.63839084829, 12089.516419343128, 12858.614241572768, 12895.290759007969, 13145.474181033034, 13405.798913016117, 13984.300784960915, 9493.952530237304, 11541.942290288494, 12347.814782778445, 12360.75278494443, 12521.749565008831, 12362.567310144103, 12482.188657737219, 12511.749765004466, 12672.493100275886, 13175.670608234488, 12360.072994525266, 12551.811722823983, 12649.620511384674, 13126.934365328112, 13517.256550889795, 10517.368957862553, 10582.365058096539, 10677.199210059121, 10892.891071089187, 10898.836517452402, 10659.307145035547, 10705.785884282115, 10760.569577216824, 10773.353598784099, 10894.704808277744], "value": 6662.721107763047, "unit": "score"}], "name": "dromaeo_css", "value": 7032.532147817879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 110.0, 110.0, 110.0, 98.0, 110.0, 110.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 151.0, 174.0, 125.0, 156.0, 158.0, 128.0, 181.0, 124.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 158.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 96.0, 114.0, 74.0, 73.0, 73.0, 125.0, 101.0, 73.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 147.0, 94.0, 93.0, 94.0, 149.0, 93.0, 93.0, 154.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 57.0, 73.0, 57.0, 53.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 77.0, 79.0, 78.0, 79.0, 79.0, 79.0, 80.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 129.0, 126.0, 124.0, 124.0, 126.0, 127.0, 161.0, 129.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 168.0, 168.0, 162.0, 165.0, 172.0, 165.0, 163.0, 161.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 69.0, 68.0, 67.0, 67.0, 75.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1534.7000000000003, "alertThreshold": 2.0}]} 01:22:04 INFO - Return code: 0 01:22:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:22:04 ERROR - # TBPL SUCCESS # 01:22:04 INFO - Running post-action listener: _resource_record_post_action 01:22:04 INFO - Running post-run listener: _resource_record_post_run 01:22:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 535257088; Read time: 0; Write time: 732764 01:22:06 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 243859456; Read time: 0; Write time: 423960 01:22:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291397632; Read time: 0; Write time: 308804 01:22:06 INFO - Running post-run listener: _upload_blobber_files 01:22:06 INFO - Blob upload gear active. 01:22:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:22:06 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 01:22:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:22:06 INFO - (blobuploader) - INFO - Open directory for files ... 01:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:22:07 INFO - (blobuploader) - INFO - Done attempting. 01:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:22:07 INFO - (blobuploader) - INFO - Done attempting. 01:22:07 INFO - (blobuploader) - INFO - Iteration through files over. 01:22:07 INFO - Return code: 0 01:22:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:22:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:22:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39b8022a53c443467445c8e12d0be94b05f4cd43122a7e6d9068072b00cc40005baec68fb9f016a5dca60eecab1c2db3b761cd96afd34e29b841b105cc54d281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56757009d21438ea8a118148eb15e25d749fd1c20d1085778b1e3591a6fcc4c72a9b93d9220c2a9cca97909491533330758fdf5676fd767029043d2ae1be73f2"} 01:22:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:22:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:22:07 INFO - Contents: 01:22:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39b8022a53c443467445c8e12d0be94b05f4cd43122a7e6d9068072b00cc40005baec68fb9f016a5dca60eecab1c2db3b761cd96afd34e29b841b105cc54d281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56757009d21438ea8a118148eb15e25d749fd1c20d1085778b1e3591a6fcc4c72a9b93d9220c2a9cca97909491533330758fdf5676fd767029043d2ae1be73f2"} 01:22:07 INFO - Running post-run listener: copy_logs_to_upload_dir 01:22:07 INFO - Copying logs to upload dir... 01:22:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:22:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.124368 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-10 01:22:07.846936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 01:22:07.850117) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39b8022a53c443467445c8e12d0be94b05f4cd43122a7e6d9068072b00cc40005baec68fb9f016a5dca60eecab1c2db3b761cd96afd34e29b841b105cc54d281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56757009d21438ea8a118148eb15e25d749fd1c20d1085778b1e3591a6fcc4c72a9b93d9220c2a9cca97909491533330758fdf5676fd767029043d2ae1be73f2"} build_url:https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/dFX2DCkHTPaYcsPsIKJNTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39b8022a53c443467445c8e12d0be94b05f4cd43122a7e6d9068072b00cc40005baec68fb9f016a5dca60eecab1c2db3b761cd96afd34e29b841b105cc54d281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56757009d21438ea8a118148eb15e25d749fd1c20d1085778b1e3591a6fcc4c72a9b93d9220c2a9cca97909491533330758fdf5676fd767029043d2ae1be73f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 01:22:07.876038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:22:07.876378) ========= 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=aa52b8aba932b19cc50b5275000001de-1460271600.836250-799504910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 01:22:07.959976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 01:22:07.960460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 01:22:07.960805) ========= ========= Total master_lag: 0.30 =========