builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1458071225.63 results: success (0) buildid: 20160315100943 builduid: 4430052a489f495b8c6d0e9d3b50466b revision: a0b6df7c6f43c373abd59a2297241bebf2416e8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.632224) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.632686) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.633045) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.656489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.656821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.681340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.681779) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.731469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.731869) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.732455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.732845) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 12:47:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2016-03-15 12:47:05 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.909364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:05.909679) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078780 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.002125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.002992) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a0b6df7c6f43c373abd59a2297241bebf2416e8a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a0b6df7c6f43c373abd59a2297241bebf2416e8a --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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 12:47:06,065 truncating revision to first 12 chars 2016-03-15 12:47:06,065 Setting DEBUG logging. 2016-03-15 12:47:06,065 attempt 1/10 2016-03-15 12:47:06,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a0b6df7c6f43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 12:47:06,312 unpacking tar archive at: mozilla-aurora-a0b6df7c6f43/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.540311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.540763) ========= echo a0b6df7c6f43c373abd59a2297241bebf2416e8a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a0b6df7c6f43c373abd59a2297241bebf2416e8a'] 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a0b6df7c6f43c373abd59a2297241bebf2416e8a program finished with exit code 0 elapsedTime=0.003530 script_repo_revision: 'a0b6df7c6f43c373abd59a2297241bebf2416e8a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.588486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.588768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:47:06.598700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-15 12:47:06.598971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:47:06 INFO - MultiFileLogger online at 20160315 12:47:06 in /builds/slave/test-pgo 12:47:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:47:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:47:06 INFO - {'append_to_log': False, 12:47:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:47:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:47:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:47:06 INFO - 'branch': 'Mozilla-Aurora', 12:47:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:06 INFO - 'config_files': ('talos/linux_config.py',), 12:47:06 INFO - 'default_actions': ('clobber', 12:47:06 INFO - 'read-buildbot-config', 12:47:06 INFO - 'download-and-extract', 12:47:06 INFO - 'populate-webroot', 12:47:06 INFO - 'create-virtualenv', 12:47:06 INFO - 'install', 12:47:06 INFO - 'run-tests'), 12:47:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:06 INFO - 'download_minidump_stackwalk': True, 12:47:06 INFO - 'download_symbols': 'ondemand', 12:47:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:06 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:06 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:06 INFO - 'installer_path': 'installer.exe', 12:47:06 INFO - 'log_level': 'info', 12:47:06 INFO - 'log_name': 'talos', 12:47:06 INFO - 'log_to_console': True, 12:47:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:47:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:47:06 INFO - 'opt_config_files': (), 12:47:06 INFO - 'pip_index': False, 12:47:06 INFO - 'sps_profile': False, 12:47:06 INFO - 'sps_profile_interval': 0, 12:47:06 INFO - 'suite': 'dromaeojs', 12:47:06 INFO - 'system_bits': '32', 12:47:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:06 INFO - 'title': 'talos-linux64-ix-010', 12:47:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:06 INFO - 'use_talos_json': True, 12:47:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:47:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:06 INFO - 'work_dir': 'build'} 12:47:06 INFO - ##### 12:47:06 INFO - ##### Running clobber step. 12:47:06 INFO - ##### 12:47:06 INFO - Running pre-action listener: _resource_record_pre_action 12:47:06 INFO - Running main action method: clobber 12:47:06 INFO - rmtree: /builds/slave/test-pgo/build 12:47:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:47:13 INFO - Running post-action listener: _resource_record_post_action 12:47:13 INFO - ##### 12:47:13 INFO - ##### Running read-buildbot-config step. 12:47:13 INFO - ##### 12:47:13 INFO - Running pre-action listener: _resource_record_pre_action 12:47:13 INFO - Running main action method: read_buildbot_config 12:47:13 INFO - Using buildbot properties: 12:47:13 INFO - { 12:47:13 INFO - "project": "", 12:47:13 INFO - "product": "firefox", 12:47:13 INFO - "script_repo_revision": "production", 12:47:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:47:13 INFO - "repository": "", 12:47:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:47:13 INFO - "buildid": "20160315100943", 12:47:13 INFO - "pgo_build": "True", 12:47:13 INFO - "basedir": "/builds/slave/test-pgo", 12:47:13 INFO - "buildnumber": 113, 12:47:13 INFO - "slavename": "talos-linux64-ix-010", 12:47:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:47:13 INFO - "platform": "ubuntu64_hw", 12:47:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:47:13 INFO - "branch": "mozilla-aurora", 12:47:13 INFO - "repo_path": "releases/mozilla-aurora", 12:47:13 INFO - "revision": "a0b6df7c6f43c373abd59a2297241bebf2416e8a", 12:47:13 INFO - "stage_platform": "linux64-pgo", 12:47:13 INFO - "builduid": "4430052a489f495b8c6d0e9d3b50466b", 12:47:13 INFO - "slavebuilddir": "test" 12:47:13 INFO - } 12:47:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 12:47:13 INFO - Running post-action listener: _resource_record_post_action 12:47:13 INFO - ##### 12:47:13 INFO - ##### Running download-and-extract step. 12:47:13 INFO - ##### 12:47:13 INFO - Running pre-action listener: _resource_record_pre_action 12:47:13 INFO - Running main action method: download_and_extract 12:47:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:13 INFO - https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:47:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:47:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:47:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:47:14 INFO - Downloaded 1448 bytes. 12:47:14 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 12:47:14 INFO - Using the following test package requirements: 12:47:14 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:47:14 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:47:14 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:47:14 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'jsshell-linux-x86_64.zip'], 12:47:14 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:47:14 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:47:14 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:47:14 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:47:14 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:47:14 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 12:47:14 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 12:47:14 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:47:14 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:14 INFO - https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:47:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:47:17 INFO - Downloaded 23308297 bytes. 12:47:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:47:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:47:18 INFO - Return code: 0 12:47:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:47:18 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')]} 12:47:18 INFO - https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 12:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:47:30 INFO - Downloaded 23308297 bytes. 12:47:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:47:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:47:31 INFO - Return code: 0 12:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:31 INFO - https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 12:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:47:32 INFO - Downloaded 10845161 bytes. 12:47:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:47:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:47:32 INFO - Return code: 0 12:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:32 INFO - https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:47:35 INFO - Downloaded 60445183 bytes. 12:47:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:47:35 INFO - mkdir: /builds/slave/test-pgo/properties 12:47:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:47:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:47:35 INFO - Contents: 12:47:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 12:47:36 INFO - Running post-action listener: _resource_record_post_action 12:47:36 INFO - Running post-action listener: set_extra_try_arguments 12:47:36 INFO - ##### 12:47:36 INFO - ##### Running populate-webroot step. 12:47:36 INFO - ##### 12:47:36 INFO - Running pre-action listener: _resource_record_pre_action 12:47:36 INFO - Running main action method: populate_webroot 12:47:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:36 INFO - '--tppagecycles', 12:47:36 INFO - '7'], 12:47:36 INFO - 'tests': ['tsvgm']}}, 12:47:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:47:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:47:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:47:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'tests': ['damp', 'tps']}, 12:47:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['damp', 'tps']}, 12:47:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:47:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:36 INFO - 'other': {'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'other_l64': {'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'other_nol64': {'tests': ['a11yr', 12:47:36 INFO - 'ts_paint', 12:47:36 INFO - 'tpaint', 12:47:36 INFO - 'sessionrestore', 12:47:36 INFO - 'sessionrestore_no_auto_restore', 12:47:36 INFO - 'tabpaint']}, 12:47:36 INFO - 'svgr': {'tests': ['tsvgx', 12:47:36 INFO - 'tsvgr_opacity', 12:47:36 INFO - 'tart', 12:47:36 INFO - 'tscrollx', 12:47:36 INFO - 'cart']}, 12:47:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['tsvgx', 12:47:36 INFO - 'tsvgr_opacity', 12:47:36 INFO - 'tart', 12:47:36 INFO - 'tscrollx', 12:47:36 INFO - 'cart']}, 12:47:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'tests': ['tp5o']}, 12:47:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'talos_options': ['--e10s'], 12:47:36 INFO - 'tests': ['tp5o']}, 12:47:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'talos_options': ['--xperf_path', 12:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:36 INFO - 'tests': ['tp5n']}, 12:47:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:36 INFO - 'talos_options': ['--e10s', 12:47:36 INFO - '--xperf_path', 12:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:36 INFO - 'tests': ['tp5n']}}, 12:47:36 INFO - 'talos.zip': {'path': '', 12:47:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:36 INFO - Running post-action listener: _resource_record_post_action 12:47:36 INFO - ##### 12:47:36 INFO - ##### Running create-virtualenv step. 12:47:36 INFO - ##### 12:47:36 INFO - Running pre-action listener: _resource_record_pre_action 12:47:36 INFO - Running main action method: create_virtualenv 12:47:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:47:36 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 12:47:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:47:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:36 INFO - Using real prefix '/usr' 12:47:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:47:36 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:38 INFO - Installing pip.................done. 12:47:38 INFO - Return code: 0 12:47:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:38 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:38 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 12:47:38 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 12:47:38 INFO - Using env: {'DISPLAY': ':0', 12:47:38 INFO - 'HOME': '/home/cltbld', 12:47:38 INFO - 'LANG': 'en_US.UTF-8', 12:47:38 INFO - 'LANGUAGE': 'en_US:en', 12:47:38 INFO - 'LOGNAME': 'cltbld', 12:47:38 INFO - 'MAIL': '/var/mail/cltbld', 12:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:38 INFO - 'MOZ_NO_REMOTE': '1', 12:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:38 INFO - 'NO_EM_RESTART': '1', 12:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:38 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:38 INFO - 'SHELL': '/bin/bash', 12:47:38 INFO - 'SHLVL': '1', 12:47:38 INFO - 'TERM': 'linux', 12:47:38 INFO - 'TMOUT': '86400', 12:47:38 INFO - 'USER': 'cltbld', 12:47:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:38 INFO - '_': '/tools/buildbot/bin/python'} 12:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:38 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 12:47:38 INFO - Cleaning up... 12:47:38 INFO - Return code: 0 12:47:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:38 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:38 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 12:47:38 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 12:47:38 INFO - Using env: {'DISPLAY': ':0', 12:47:38 INFO - 'HOME': '/home/cltbld', 12:47:38 INFO - 'LANG': 'en_US.UTF-8', 12:47:38 INFO - 'LANGUAGE': 'en_US:en', 12:47:38 INFO - 'LOGNAME': 'cltbld', 12:47:38 INFO - 'MAIL': '/var/mail/cltbld', 12:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:38 INFO - 'MOZ_NO_REMOTE': '1', 12:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:38 INFO - 'NO_EM_RESTART': '1', 12:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:38 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:38 INFO - 'SHELL': '/bin/bash', 12:47:38 INFO - 'SHLVL': '1', 12:47:38 INFO - 'TERM': 'linux', 12:47:38 INFO - 'TMOUT': '86400', 12:47:38 INFO - 'USER': 'cltbld', 12:47:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:38 INFO - '_': '/tools/buildbot/bin/python'} 12:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:39 INFO - Downloading/unpacking psutil>=0.7.1 12:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:41 INFO - Installing collected packages: psutil 12:47:41 INFO - Running setup.py install for psutil 12:47:41 INFO - building 'psutil._psutil_linux' extension 12:47:41 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 12:47:41 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 12:47:41 INFO - building 'psutil._psutil_posix' extension 12:47:41 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 12:47:41 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 12:47:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:41 INFO - Successfully installed psutil 12:47:41 INFO - Cleaning up... 12:47:41 INFO - Return code: 0 12:47:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:47:41 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')]} 12:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 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')]} 12:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:41 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 12:47:41 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 12:47:41 INFO - Using env: {'DISPLAY': ':0', 12:47:41 INFO - 'HOME': '/home/cltbld', 12:47:41 INFO - 'LANG': 'en_US.UTF-8', 12:47:41 INFO - 'LANGUAGE': 'en_US:en', 12:47:41 INFO - 'LOGNAME': 'cltbld', 12:47:41 INFO - 'MAIL': '/var/mail/cltbld', 12:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:41 INFO - 'MOZ_NO_REMOTE': '1', 12:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:41 INFO - 'NO_EM_RESTART': '1', 12:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:41 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:41 INFO - 'SHELL': '/bin/bash', 12:47:41 INFO - 'SHLVL': '1', 12:47:41 INFO - 'TERM': 'linux', 12:47:41 INFO - 'TMOUT': '86400', 12:47:41 INFO - 'USER': 'cltbld', 12:47:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:41 INFO - '_': '/tools/buildbot/bin/python'} 12:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:47:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:47:43 INFO - Installing collected packages: mozsystemmonitor 12:47:43 INFO - Running setup.py install for mozsystemmonitor 12:47:43 INFO - Successfully installed mozsystemmonitor 12:47:43 INFO - Cleaning up... 12:47:43 INFO - Return code: 0 12:47:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:43 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:43 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 12:47:43 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 12:47:43 INFO - Using env: {'DISPLAY': ':0', 12:47:43 INFO - 'HOME': '/home/cltbld', 12:47:43 INFO - 'LANG': 'en_US.UTF-8', 12:47:43 INFO - 'LANGUAGE': 'en_US:en', 12:47:43 INFO - 'LOGNAME': 'cltbld', 12:47:43 INFO - 'MAIL': '/var/mail/cltbld', 12:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:43 INFO - 'MOZ_NO_REMOTE': '1', 12:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:43 INFO - 'NO_EM_RESTART': '1', 12:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:43 INFO - 'SHELL': '/bin/bash', 12:47:43 INFO - 'SHLVL': '1', 12:47:43 INFO - 'TERM': 'linux', 12:47:43 INFO - 'TMOUT': '86400', 12:47:43 INFO - 'USER': 'cltbld', 12:47:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:43 INFO - '_': '/tools/buildbot/bin/python'} 12:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:45 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 12:47:45 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 12:47:45 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 12:47:45 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 12:47:45 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 12:47:45 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 12:47:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:47:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47:46 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 12:47:46 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 12:47:46 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 12:47:46 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 12:47:46 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 12:47:46 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 12:47:46 INFO - Downloading docopt-0.6.1.tar.gz 12:47:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:46 INFO - Running setup.py install for blobuploader 12:47:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:47:46 INFO - Running setup.py install for requests 12:47:47 INFO - Running setup.py install for docopt 12:47:47 INFO - Successfully installed blobuploader requests docopt 12:47:47 INFO - Cleaning up... 12:47:47 INFO - Return code: 0 12:47:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:47 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:47 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 12:47:47 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 12:47:47 INFO - Using env: {'DISPLAY': ':0', 12:47:47 INFO - 'HOME': '/home/cltbld', 12:47:47 INFO - 'LANG': 'en_US.UTF-8', 12:47:47 INFO - 'LANGUAGE': 'en_US:en', 12:47:47 INFO - 'LOGNAME': 'cltbld', 12:47:47 INFO - 'MAIL': '/var/mail/cltbld', 12:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:47 INFO - 'MOZ_NO_REMOTE': '1', 12:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:47 INFO - 'NO_EM_RESTART': '1', 12:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:47 INFO - 'SHELL': '/bin/bash', 12:47:47 INFO - 'SHLVL': '1', 12:47:47 INFO - 'TERM': 'linux', 12:47:47 INFO - 'TMOUT': '86400', 12:47:47 INFO - 'USER': 'cltbld', 12:47:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:47 INFO - '_': '/tools/buildbot/bin/python'} 12:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:47:47 INFO - Running setup.py (path:/tmp/pip-ctHltI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:47:47 INFO - Running setup.py (path:/tmp/pip-4inXPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:47:47 INFO - Running setup.py (path:/tmp/pip-NOUu4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:47:47 INFO - Running setup.py (path:/tmp/pip-lePPoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:47:47 INFO - Running setup.py (path:/tmp/pip-LdCVAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:47:47 INFO - Running setup.py (path:/tmp/pip-FT443e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:47:47 INFO - Running setup.py (path:/tmp/pip-3NS27i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:47:48 INFO - Running setup.py (path:/tmp/pip-z0xzSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:47:48 INFO - Running setup.py (path:/tmp/pip-rrXZOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:47:48 INFO - Running setup.py (path:/tmp/pip-e2Fp0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:47:48 INFO - Running setup.py (path:/tmp/pip-LA_qf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:47:48 INFO - Running setup.py (path:/tmp/pip-S7MD3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:47:48 INFO - Running setup.py (path:/tmp/pip-l3WbTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:47:48 INFO - Running setup.py (path:/tmp/pip-8wN_xk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:47:48 INFO - Running setup.py (path:/tmp/pip-6yf1eX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:47:48 INFO - Running setup.py (path:/tmp/pip-d8DYEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:47:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:47:48 INFO - Running setup.py (path:/tmp/pip-Let_qX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:47:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:48 INFO - Running setup.py install for manifestparser 12:47:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:47:48 INFO - Running setup.py install for mozcrash 12:47:48 INFO - Running setup.py install for mozdebug 12:47:49 INFO - Running setup.py install for mozdevice 12:47:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for mozfile 12:47:49 INFO - Running setup.py install for mozhttpd 12:47:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for mozinfo 12:47:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for mozInstall 12:47:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for mozleak 12:47:49 INFO - Running setup.py install for mozlog 12:47:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for moznetwork 12:47:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:47:49 INFO - Running setup.py install for mozprocess 12:47:49 INFO - Running setup.py install for mozprofile 12:47:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:47:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:47:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:47:50 INFO - Running setup.py install for mozrunner 12:47:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:47:50 INFO - Running setup.py install for mozscreenshot 12:47:50 INFO - Running setup.py install for moztest 12:47:50 INFO - Running setup.py install for mozversion 12:47:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:47:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:50 INFO - Cleaning up... 12:47:50 INFO - Return code: 0 12:47:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:47: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')]} 12:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:50 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 12:47:50 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 12:47:50 INFO - Using env: {'DISPLAY': ':0', 12:47:50 INFO - 'HOME': '/home/cltbld', 12:47:50 INFO - 'LANG': 'en_US.UTF-8', 12:47:50 INFO - 'LANGUAGE': 'en_US:en', 12:47:50 INFO - 'LOGNAME': 'cltbld', 12:47:50 INFO - 'MAIL': '/var/mail/cltbld', 12:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:50 INFO - 'MOZ_NO_REMOTE': '1', 12:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:50 INFO - 'NO_EM_RESTART': '1', 12:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:50 INFO - 'SHELL': '/bin/bash', 12:47:50 INFO - 'SHLVL': '1', 12:47:50 INFO - 'TERM': 'linux', 12:47:50 INFO - 'TMOUT': '86400', 12:47:50 INFO - 'USER': 'cltbld', 12:47:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:50 INFO - '_': '/tools/buildbot/bin/python'} 12:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:47:50 INFO - Running setup.py (path:/tmp/pip-SDPBFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:47:50 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)) 12:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:47:50 INFO - Running setup.py (path:/tmp/pip-COqkSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:47:50 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)) 12:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:47:50 INFO - Running setup.py (path:/tmp/pip-CYozHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:47:50 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)) 12:47:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:47:50 INFO - Running setup.py (path:/tmp/pip-b9UDxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:47:51 INFO - Running setup.py (path:/tmp/pip-LlY28e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:47:51 INFO - Running setup.py (path:/tmp/pip-uHPYVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:47:51 INFO - Running setup.py (path:/tmp/pip-DmXehc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:47:51 INFO - Running setup.py (path:/tmp/pip-ZujsRd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:47:51 INFO - Running setup.py (path:/tmp/pip-s3m8bw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:47:51 INFO - Running setup.py (path:/tmp/pip-G4PZH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:47:51 INFO - Running setup.py (path:/tmp/pip-UM8hYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:47:51 INFO - Running setup.py (path:/tmp/pip-SE9OSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:47:51 INFO - Running setup.py (path:/tmp/pip-blqBGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:47:51 INFO - Running setup.py (path:/tmp/pip-TBKZme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:47:51 INFO - Running setup.py (path:/tmp/pip-4GKw_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:47:51 INFO - Running setup.py (path:/tmp/pip-5nacpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:47:51 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)) 12:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:47:51 INFO - Running setup.py (path:/tmp/pip-LoHlD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:47:51 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)) 12:47:51 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)) 12:47:51 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)) 12:47:51 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)) 12:47:51 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)) 12:47:51 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)) 12:47:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:53 INFO - Downloading blessings-1.6.tar.gz 12:47:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:53 INFO - Installing collected packages: blessings 12:47:53 INFO - Running setup.py install for blessings 12:47:54 INFO - Successfully installed blessings 12:47:54 INFO - Cleaning up... 12:47:54 INFO - Return code: 0 12:47:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:47:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:47:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:47:54 INFO - Reading from file tmpfile_stdout 12:47:54 INFO - Current package versions: 12:47:54 INFO - argparse == 1.2.1 12:47:54 INFO - blessings == 1.6 12:47:54 INFO - blobuploader == 1.2.4 12:47:54 INFO - docopt == 0.6.1 12:47:54 INFO - manifestparser == 1.1 12:47:54 INFO - mozInstall == 1.12 12:47:54 INFO - mozcrash == 0.17 12:47:54 INFO - mozdebug == 0.1 12:47:54 INFO - mozdevice == 0.48 12:47:54 INFO - mozfile == 1.2 12:47:54 INFO - mozhttpd == 0.7 12:47:54 INFO - mozinfo == 0.9 12:47:54 INFO - mozleak == 0.1 12:47:54 INFO - mozlog == 3.1 12:47:54 INFO - moznetwork == 0.27 12:47:54 INFO - mozprocess == 0.22 12:47:54 INFO - mozprofile == 0.28 12:47:54 INFO - mozrunner == 6.11 12:47:54 INFO - mozscreenshot == 0.1 12:47:54 INFO - mozsystemmonitor == 0.0 12:47:54 INFO - moztest == 0.7 12:47:54 INFO - mozversion == 1.4 12:47:54 INFO - psutil == 3.1.1 12:47:54 INFO - requests == 1.2.3 12:47:54 INFO - wsgiref == 0.1.2 12:47:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:47:54 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')]} 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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')]} 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:54 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 12:47:54 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 12:47:54 INFO - Using env: {'DISPLAY': ':0', 12:47:54 INFO - 'HOME': '/home/cltbld', 12:47:54 INFO - 'LANG': 'en_US.UTF-8', 12:47:54 INFO - 'LANGUAGE': 'en_US:en', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MAIL': '/var/mail/cltbld', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SHLVL': '1', 12:47:54 INFO - 'TERM': 'linux', 12:47:54 INFO - 'TMOUT': '86400', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - '_': '/tools/buildbot/bin/python'} 12:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 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)) 12:47:54 INFO - Cleaning up... 12:47:54 INFO - Return code: 0 12:47:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:47:54 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')]} 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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')]} 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:54 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:54 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 12:47:54 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 12:47:54 INFO - Using env: {'DISPLAY': ':0', 12:47:54 INFO - 'HOME': '/home/cltbld', 12:47:54 INFO - 'LANG': 'en_US.UTF-8', 12:47:54 INFO - 'LANGUAGE': 'en_US:en', 12:47:54 INFO - 'LOGNAME': 'cltbld', 12:47:54 INFO - 'MAIL': '/var/mail/cltbld', 12:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:54 INFO - 'MOZ_NO_REMOTE': '1', 12:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:54 INFO - 'NO_EM_RESTART': '1', 12:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:54 INFO - 'SHELL': '/bin/bash', 12:47:54 INFO - 'SHLVL': '1', 12:47:54 INFO - 'TERM': 'linux', 12:47:54 INFO - 'TMOUT': '86400', 12:47:54 INFO - 'USER': 'cltbld', 12:47:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:54 INFO - '_': '/tools/buildbot/bin/python'} 12:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:54 INFO - Downloading/unpacking jsonschema 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:56 INFO - Downloading/unpacking functools32 (from jsonschema) 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:56 INFO - warning: no files found matching '*.txt' 12:47:56 INFO - no previously-included directories found matching 'build' 12:47:56 INFO - no previously-included directories found matching 'dist' 12:47:56 INFO - no previously-included directories found matching '.git*' 12:47:56 INFO - Installing collected packages: jsonschema, functools32 12:47:56 INFO - Running setup.py install for functools32 12:47:56 INFO - warning: no files found matching '*.txt' 12:47:56 INFO - no previously-included directories found matching 'build' 12:47:56 INFO - no previously-included directories found matching 'dist' 12:47:56 INFO - no previously-included directories found matching '.git*' 12:47:57 INFO - Successfully installed jsonschema functools32 12:47:57 INFO - Cleaning up... 12:47:57 INFO - Return code: 0 12:47:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:47:57 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')]} 12:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:57 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')]} 12:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:57 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 0x7f5b2d3dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d36d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, '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': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', '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 12:47:57 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 12:47:57 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 12:47:57 INFO - Using env: {'DISPLAY': ':0', 12:47:57 INFO - 'HOME': '/home/cltbld', 12:47:57 INFO - 'LANG': 'en_US.UTF-8', 12:47:57 INFO - 'LANGUAGE': 'en_US:en', 12:47:57 INFO - 'LOGNAME': 'cltbld', 12:47:57 INFO - 'MAIL': '/var/mail/cltbld', 12:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:57 INFO - 'MOZ_NO_REMOTE': '1', 12:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:57 INFO - 'NO_EM_RESTART': '1', 12:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:47:57 INFO - 'SHELL': '/bin/bash', 12:47:57 INFO - 'SHLVL': '1', 12:47:57 INFO - 'TERM': 'linux', 12:47:57 INFO - 'TMOUT': '86400', 12:47:57 INFO - 'USER': 'cltbld', 12:47:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:57 INFO - '_': '/tools/buildbot/bin/python'} 12:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:57 INFO - Downloading/unpacking flake8 12:47:57 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 12:47:57 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 12:47:57 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 12:47:57 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 12:47:57 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 12:47:57 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 12:47:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:47:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:47:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:47:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:59 INFO - no previously-included directories found matching 'docs/_build' 12:47:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:47:59 INFO - Running setup.py install for pep8 12:47:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:47:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:47:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:47:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:47:59 INFO - no previously-included directories found matching 'docs/_build' 12:48:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:48:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:48:00 INFO - Cleaning up... 12:48:00 INFO - Return code: 0 12:48:00 INFO - Running post-action listener: _resource_record_post_action 12:48:00 INFO - Running post-action listener: _start_resource_monitoring 12:48:00 INFO - Starting resource monitoring. 12:48:00 INFO - ##### 12:48:00 INFO - ##### Running install step. 12:48:00 INFO - ##### 12:48:00 INFO - Running pre-action listener: _resource_record_pre_action 12:48:00 INFO - Running main action method: install 12:48:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:48:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:48:00 INFO - Reading from file tmpfile_stdout 12:48:00 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:48:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:48:00 INFO - Reading from file tmpfile_stdout 12:48:00 INFO - Output received: 12:48:00 INFO - Usage: mozinstall [options] installer 12:48:00 INFO - Options: 12:48:00 INFO - -h, --help show this help message and exit 12:48:00 INFO - -d DEST, --destination=DEST 12:48:00 INFO - Directory to install application into. [default: 12:48:00 INFO - "/builds/slave/test-pgo"] 12:48:00 INFO - --app=APP Application being installed. [default: firefox] 12:48:00 INFO - mkdir: /builds/slave/test-pgo/build/application 12:48:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:48:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:48:15 INFO - Reading from file tmpfile_stdout 12:48:15 INFO - Output received: 12:48:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:48:15 INFO - Running post-action listener: _resource_record_post_action 12:48:15 INFO - ##### 12:48:15 INFO - ##### Running run-tests step. 12:48:15 INFO - ##### 12:48:15 INFO - Running pre-action listener: _resource_record_pre_action 12:48:15 INFO - Running main action method: run_tests 12:48:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:48:15 INFO - Python 2.7.3 12:48:15 INFO - Return code: 0 12:48:15 INFO - grabbing minidump binary from tooltool 12:48: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')]} 12:48:15 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 0x1962920>, '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 0x1963820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1963cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:48:15 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 12:48:15 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 12:48:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:15 INFO - Return code: 0 12:48:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:48:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:48:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:48:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:48:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:48:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:48:16 INFO - Return code: 0 12:48:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:48:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 12:48:16 INFO - Using env: {'DISPLAY': ':0', 12:48:16 INFO - 'HOME': '/home/cltbld', 12:48:16 INFO - 'LANG': 'en_US.UTF-8', 12:48:16 INFO - 'LANGUAGE': 'en_US:en', 12:48:16 INFO - 'LOGNAME': 'cltbld', 12:48:16 INFO - 'MAIL': '/var/mail/cltbld', 12:48:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:48:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:16 INFO - 'MOZ_NO_REMOTE': '1', 12:48:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:16 INFO - 'NO_EM_RESTART': '1', 12:48:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:16 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:48:16 INFO - 'SHELL': '/bin/bash', 12:48:16 INFO - 'SHLVL': '1', 12:48:16 INFO - 'TERM': 'linux', 12:48:16 INFO - 'TMOUT': '86400', 12:48:16 INFO - 'USER': 'cltbld', 12:48:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765', 12:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:16 INFO - '_': '/tools/buildbot/bin/python'} 12:48:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:48:16 INFO - mozversion application_buildid: 20160315100943 12:48:16 INFO - mozversion application_changeset: a0b6df7c6f43c373abd59a2297241bebf2416e8a 12:48:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:48:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:16 INFO - mozversion application_name: Firefox 12:48:16 INFO - mozversion application_remotingname: firefox-dev 12:48:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:48:16 INFO - mozversion application_vendor: Mozilla 12:48:16 INFO - mozversion application_version: 47.0a2 12:48:16 INFO - mozversion platform_buildid: 20160315100943 12:48:16 INFO - mozversion platform_changeset: a0b6df7c6f43c373abd59a2297241bebf2416e8a 12:48:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:48:16 INFO - mozversion platform_version: 47.0a2 12:48:16 INFO - using testdate: 1458071296 12:48:16 INFO - actual date: 1458071296 12:48:16 INFO - starting webserver on 'localhost:45160' 12:48:16 INFO - SUITE-START | Running 2 tests 12:48:16 INFO - TEST-START | dromaeo_css 12:48:16 INFO - operating with platform_type : linux_ 12:48:16 INFO - Initialising browser for dromaeo_css test... 12:48:16 INFO - TEST-INFO | started process 15705 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpguum6Z/profile http://localhost:45160/getInfo.html) 12:48:21 INFO - PROCESS | 15705 | __metrics Screen width/height:1600/1200 12:48:21 INFO - PROCESS | 15705 | colorDepth:24 12:48:21 INFO - PROCESS | 15705 | Browser inner width/height: 1024/697 12:48:21 INFO - PROCESS | 15705 | __metrics 12:48:22 INFO - PROCESS | 15705 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:23 INFO - TEST-INFO | 15705: exit 0 12:48:23 INFO - Browser initialized. 12:48:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:48:23 INFO - TEST-INFO | started process 15798 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpguum6Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:35 INFO - PROCESS | 15798 | RSS: Main: 144109568 12:48:35 INFO - PROCESS | 15798 | 12:49:26 INFO - PROCESS | 15798 | 1458071366552 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] 12:51:33 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45160/tests/dromaeo/cssquery-ext.html) 12:51:35 INFO - PROCESS | 15798 | RSS: Main: 253378560 12:51:35 INFO - PROCESS | 15798 | 12:54:37 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-ext.html (next: http://localhost:45160/tests/dromaeo/cssquery-jquery.html) 12:54:37 INFO - PROCESS | 15798 | RSS: Main: 219570176 12:54:37 INFO - PROCESS | 15798 | 12:57:39 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45160/tests/dromaeo/cssquery-mootools.html) 12:57:39 INFO - PROCESS | 15798 | RSS: Main: 215371776 12:57:39 INFO - PROCESS | 15798 | 13:00:41 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45160/tests/dromaeo/cssquery-prototype.html) 13:00:42 INFO - PROCESS | 15798 | RSS: Main: 192851968 13:00:42 INFO - PROCESS | 15798 | 13:03:44 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45160/tests/dromaeo/cssquery-yui.html) 13:03:45 INFO - PROCESS | 15798 | RSS: Main: 208769024 13:03:45 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | Cycle 1(1): loaded http://localhost:45160/tests/dromaeo/cssquery-yui.html (next: http://localhost:45160/tests/dromaeo/cssquery-dojo.html) 13:06:47 INFO - PROCESS | 15798 | RSS: Main: 254902272 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | __start_tp_report 13:06:47 INFO - PROCESS | 15798 | _x_x_mozilla_page_load 13:06:47 INFO - PROCESS | 15798 | _x_x_mozilla_page_load_details 13:06:47 INFO - PROCESS | 15798 | |i|pagename|runs| 13:06:47 INFO - PROCESS | 15798 | |0;dojo.html;3204.359128174365;3260.250142467234;3270.8037517748935;3281.5898012748407;3298.587676540432;5276.419593844674;5297.735113244342;5308.628396012281;5321.973390133049;5322.308099947001;5287.920681189786;5318.042752304594;5322.8137015204475;5345.7059861707685;5347.679139251638;4761.190597598416;4868.659193856432;4873.951260487394;4918.5327393897705;4977.203647416414;4776.140294746944;4798.568128868401;4855.660103792736;4858.174110401223;4858.927116093261;4786.066716990188;4970.030843985406;4982.2526621006955;5011.548960593545;5057.190849464087;4974.4528101908945;4988.8503344899345;5006.899862002776;5009.4239162496415;5036.093503169446;4478.57453541913;4835.298881662175;4860.441049279343;4894.119058569456;4916.901661966741;5159.638825282232;5168.9224661630105;5189.766460509286;5230.607704422146;5236.633435659505;5529.889402211974;5628.521575666074;5708.686022268774;5770.2498675171955;5781.71091445426;5725.799597014085;5757.251557297566;5793.449622285876;5796.797112101099;5834.824955251349;5364.088105022156;5368.973155134199;5374.086405311106;5394.487523685244;5395.81114660985;5740.167675687002;5870.0607902735355;5870.412958704095;5892.234009578728;5986;5722.77108915647;5728.05487094633;5728.398518155617;5733.025385684444;5767.394423585463;5769.538436925036;5774;5776.855578610484;5777.653340799566;5798.565107616945;5556.472135147154;5737;5751.051076572402;5758.078707406795;5796.449337312949;5810.215620891126;5810.5061069809535;5815.040518314515;5828.970855145697;5835;4408.53710360414;4426.26966550522;4436.800343984529;4456.131054444352;4475.552444755564;3906.121122747359;3946.1515774108702;3976.848208326286;4006.2187873364414;4032.516098068251;5454.045542030208;5478.397376288605;5482.314710661168;5485.753141108659;5487.670739755627;5788.131780232999;5809.82570522885;5814.651120932757;5826.242588463472;5859.121131830174;5310.92033619496;5455.5908306877145;5468.945310546923;5478.397376288605;5530.474604912527;4991.725455099931;5007.298978143063;5012.598992080625;5021.49785021495;5052.873678158076;5756.481916627524;5975.880482390415;5982.551308651869;5990.520758339322;6017.518598512196;5803.187553742564;5826.883462330815;5855.975204339309;5860.09168578871;5868.970655146697;5947.316058653138;5954.642721436728;5960.4635582797755;5965.403459654;5976.462118409364;5547.528460080938;5647.124695672013;5719.113537401709;5723.399043100415;5723.627964182315;5743.908657355256;5777.566682498914;5784.479396854304;5784.739686714024;5819.738111784895;5634.661920284796;5636.887262254814;5637.351704554028;5640.238567793295;5642.774289028557;5442.047641662614;5582.302212223472;5594.608377413542;5619.904118696978;5638.9436105638415;5588.3573389060775;5597;5597.160425936142;5597.63615365;5603.131514615241;5639.2668953035845;5702.486776190163;5709.25779648643;5738.340090889601;5744.368119506935;5410.864728381822;5598.412166722435;5639.492445679908;5652.180433836988;5664.688442135557 13:06:47 INFO - PROCESS | 15798 | |1;ext.html;555.0841112164925;576.7433492096019;578.3031447106238;641.2017038786711;647.8509942713177;38990;39962.80018599907;39979.20041599166;39985;39991.40012899809;43334.13331733363;43904.3414348785;43934.12131757363;43942.34086488705;44000;8868.911310886906;9079.137481939206;9081.273498120134;9088.318376121817;9091.363604547685;8895.822083558325;9034.186923176912;9047.140521650434;9048.502332371718;9051.683191088314;9246.398984066047;9326.1606455419;9328.673496427626;9359.906400936006;9361;9207.4475531468;9270.026647202081;9286.257099432029;9287.628494860197;9289.163975242227;9150.450972941644;9274.53627318638;9280.907190928072;9282.164605185566;9283.39657922233;43146;43553.78223108896;43634;43679.56320436787;43681.34477982833;3753.906152346186;3802.182530755873;3833.769973801581;3970.4242884781834;4299.204647140289;32820;32973.34053318944;33207.3358532828;33304.50043249353;33386.49920251198;3623.148560088377;3691.354013047706;3750.6436888495823;3780.546334439885;3809.923801523954;274645;275365;275392;276004;276190;48965.755171223915;62292.37707622956;62317;62621.68689156525;62639.68680156661;47019;47248.76375618169;47284.29073563899;47333.5266647336;47419.76290118528;16693.6661266774;16994.150292485327;17027.233774480177;17043.82956170447;17051.14744262782;12421.254724716366;12568.183068100545;12572.685682858002;12574.182678125893;12584.496620135274;15580.532584022498;15588.454404095803;15633.843661563466;15641;15654.843451565339;6162.599431037058;6208.85794400931;6262.749490020439;6342.651154186564;6343.714532846033;1061.7557961668858;1069.6149386220955;1091.2088735666578;1094.6059418609295;1134.846795682589;30281;30387.696123038928;30929.381412371626;30980.84509577483;31111.688883111332;1135.6990397544657;1151.746615744535;1156.0578228576073;1163.1973937982764;1180.2741314091943;15655.68688626244;15823.525294241192;15932.203389830695;16392.508224753277;16445.835541644432;343823;348102;350571;350898;351168;57096;57249.71001159907;57589;57806.7109664449;57855;1360.2586590308306;1401.1102949627061;1456.2281990545027;1458.912465252067;1478.4012474947663;29960.550591740706;30001.399972000876;30001.549976750804;30243.546346804374;30567.54148687816;46644.53355466402;47162.76418617885;47341;47341.526584733714;47352;200527;201578;201979;202083;202920;30333;34645;35033.29933401369;35096;35229.82385088058;43743.12513749771;44956.325655115856;45082.3237651442;45121.0975780476;45295.773521132185;38121.61878381292;38132.237355253295;38202.80898595489;38515;38646.6135338643;37369.082946857394;37502.43746343862;38234.80882595569;38621.80689096649;38954.6104538951;38136.427953581275;38396.61603384042;38668.80665596654;38912.41631375588;39017.02457438587;33098.83450582732;33744.32511349808;33838.66161338454;34429.311413772084;34965.47551786674;26536.203913882615;26544.469110618065;26745.408385893526;26845.597316040665;26900.865495672395 13:06:47 INFO - PROCESS | 15798 | |2;jquery.html;370.3315515494532;372.9757565758224;376.95288088988895;391.7668986952763;395.25297188314073;17844.37544685936;18574.628507429843;19041.904790476063;19398.903005484986;19405.22379104838;17095.145242737875;17223;17806.554836129104;17815.910920445378;17831.73252401215;5018.949810501894;5099.184130539114;5145.974270128644;5152.948470515303;5159.535641792238;3979.1842672252264;4993.75031248438;5286.577073834103;5493;5518.862028449301;5515.531179849698;5516.255305533742;5530.087535556629;5530.087535556629;5538.75075621598;5484.506394424501;5713.71431428429;5954.8809023819285;6108.816735497942;6125.081237814341;5372.570194384479;5374.677519348813;5377.569794416438;5379.488948549882;5386.111291636876;20434.795652043587;21293.787062129337;21887.233946811786;21923.232686855885;21924.780752192433;2467.864267465289;2486.76375744304;2527.317624241463;2543.758342957416;2961.7778666600093;9609.375390599658;9632.614695412176;9674.419534827934;9779.070988256104;9919.553620087114;1998.4504261328252;2025.878447293167;2047.140201115535;2070.2133189388087;2076.719642848211;62285.37714622841;62512.37487625111;62749.37250627481;62860.37139628591;63159;10154.796904061877;10258.17934565233;10269;10280.897191028143;10304.433256170983;13212.801807972888;13298.401571929286;13305.600831975056;13314.93342533281;13339.799903001463;7694.846103077907;7928.6035698214855;7934;8010.359171266285;8025.357971362277;7915.643796029192;7958.124606293303;7964.283214510722;8011.959940200261;8070.757877263692;4287.656987440997;4369.9126017479475;4625.583697467244;4627.907441851212;4704.482506924235;1704.1223769758585;1750.798658154303;1808.5840256741023;1828.1316374722167;1833.8166183381554;965.3628605120587;1035.2649618770606;1043.4261156363968;1053.1048608682559;1103.9071319393743;16653.91673041627;16713.83286167147;16920.57698557546;17015.319387224372;17194;909.9454032758056;1008.2790804574764;1036.2021243642353;1041.5521325829966;1110.9722256943642;9821.754456138653;10065.69802905914;10073.597056117673;10086.142677872316;10144.543495542719;161332;161947.19026404794;162074.1896290511;162311;162697;72401;73982.6300868503;74258;74280.25719742733;75344.62327688327;1047.1570385839473;1053.6154303679255;1058.5765693722572;1063.9627613033506;1080.3247970018738;15456.613584660474;15476.380944762084;15573;15960.361585536448;16338.428155014517;31913.521297180097;33490.497642534894;33659;33710.83144584261;33978;38977;40889.59110408858;42863;43750.78124609357;44041.339379908684;8316.251537361666;8421.873671894804;8437.198466145706;8607.268382187583;8684.131586841266;8710.564471776512;11875.584354547549;13136.146150500186;13196.538121165713;13266.933665331611;8985.831841860516;10098.49507524606;11285.605003824827;11325.037371823488;11440.370779607201;10706;10950.616728414467;11062.115030797679;11163.609273675382;11447.542098316308;10733.409662468326;10773.89226107729;11079.390633515233;11340.149488788209;11600.245984011011;8144.918550814416;8389.412741108064;8460.407771455939;8476.449030812977;8708.303335733253;8486;10912.945435272773;11336.659900203007;11424.314541127558;11443.771124577628 13:06:47 INFO - PROCESS | 15798 | |3;mootools.html;1427.37195633921;1574.7716581095742;1593.1237819199437;1851.4260579220443;1966.3117908731954;7491.513051651639;7975.800604984878;8063.758087257377;8072.677092916277;8090.838183236332;8383.91616083839;8536.359773017017;8559.486430814155;8569.785755356104;8580.871286930686;2082.562661841015;2131.328631481086;2366.7869891709743;2374.513224788914;2396.4607963208227;2403.723571789249;2414.167112346238;2417.226487523993;2417.516496700658;2420.7579242075826;2240.406292332533;2301.5166814968875;2367.1951536477595;2367.8816059197056;2368.5736567417857;2342;2349.9765002349927;2364.1016413762745;2429.6598476213344;2433.6349547568007;2376.619740841457;2378.6432035194684;2381.071382160959;2384.8569085854906;2462.987685061581;8227.465214761081;8255.958720206361;8262.586870656443;8264;8276;5113.693178409308;5236.7119808410525;5274.551663108602;5276.868078298035;5277.155655095205;3128.2179455136215;3159.3207460395897;3181.5068664357063;3186.0282613802783;3211.823349715765;904.2449554621899;905.0496978172893;994.5126887824986;1006.3559322033905;1031.6440827914357;12240.265584064895;12356.62930112098;12368.567100151451;12374.690632734164;12389.256644601353;4503.842365517191;4603.332516785047;4635.95364046362;4642.326862604903;4670.789814458358;10511.054005139422;10547.894521054845;10556.947215264028;10561.049505544384;10573.682789516326;5246.632735708464;5257.211418287287;5258.2638430619745;5259.921101183485;5264;4087.141700242982;4518.932216016762;4609.423822022247;4640.677406939006;4650.4186976627925;3912.1784425270444;3934.232824599233;3992.8802135935966;4005.399190121505;4042.171354872244;1197.6586672798385;1235.0983781839127;1241.6461308527028;1254.4605819497522;1280.3726174174774;1221.7251118498446;1250.8248845161684;1260.9369531523387;1512.2287633307092;1515.9469418570297;8060.355171586376;8286.798414229903;8333.291670207978;8336.666533338599;8339.708110216114;507.8222622082242;508.6210772974158;508.92366145078535;510.9182530795055;520.10541867987;5996.460318571262;6051.364606716319;6051.818445446644;6090.842739879408;6101.755929762849;9908.256880733974;10215.795684086277;10269.640562580274;10284.074433301039;10295.639652612272;9831.36096153762;10073.899261007296;10122.190224782;10127.341722787995;10139.695809125738;8094.473859199134;8134.877976830352;8224.300934420522;8231.95884020576;8245.711400101087;7873.763787086396;8011.198880111942;8055.597220139087;8073.19268073188;8162.918370816215;9043.23132533742;9190.632374704937;9216.815663686555;9241.676541321021;9373.29700272496;9413.811723765622;9538.713838584854;9546.761330966781;9747.9025209747;9959.651412200537;6621.569597976116;7386.372158366384;7674;7753.806154846174;7899.249571290718;8238.093809680811;8245.95877020635;8268.2558569729;8300;8300.418970671995;7104.3961263293195;7273.927260727325;7371.336579707852;7419.962900185465;7676.846463070819;7286.927130728837;7290.380317672845;7372.926270737224;7399.852002959803;7483.476156668981;7698.730544430918;7764.650590723544;7764.84470310602;7869.213078692085;7959.124496305518;7189.352958233784;7214.819629509304;7262.164851042197;7267.927320726725;7350.448716346403;7120.2167761547225;7232.566046037255;7268.27317268269;7284.417246620364;7292.197858235696 13:06:47 INFO - PROCESS | 15798 | |4;prototype.html;351.6290313719027;351.8557391469495;358.78831489421236;361.6419744452991;362.12727327141585;5983.102534619809;6001.789937352193;6017.398260173981;6054.5459090568165;6059.939400605993;5929.466348028676;5930.495907847838;5932.080527518242;5941.673207973559;5943;4476.61948734358;4544.136614043321;4590.334401511779;4609.654275929302;4654.3251228571835;4651.813927442899;4653.86038418848;4658.417697787777;4659.394278743758;4669.719816811003;4619.491855895849;4620.19146649335;4626.282926146453;4629.23617603095;4632.119897219518;4457;4470.150671372445;4564.726116433025;4565.383673204108;4578.9542104579195;4048.7773172475504;4050.51393832739;4052.5542190359038;4055.5133383993816;4077.8368865245357;5627.8593035174035;5629.80295689653;5629.8592535186535;5630.380658127603;5635.943640563582;5336.626436149471;5339.038972984861;5340.652857564285;5342.198670199462;5343.893122137574;6216.937830621681;6240.188775459206;6240.87518249637;6241.188645476059;6246.25044994599;4317.093410383792;4472.418585583853;4477.417935668343;4485.035717320759;4487.865364039084;6536.901946470807;6628.138342015555;6634.568753031086;6639.502037347218;6645.368689974444;4428.4243048403505;4433.046894917544;4434.312681534368;4438.245498265303;4456.665750068758;4483.843065492757;4485.372047913294;4486.304622783474;4489.932651010237;4496.078303947683;5204.141316682705;5208.296879921238;5210.843674689765;5211.661242019257;5225.895482090337;6188.226471691039;6266.655333956585;6310.8422289442215;6318.62088274705;6318.873622527523;1580.8023997000375;1595.114711335197;1599.4881637876001;1605;1606.4618352851692;1024.8513965475113;1080.5461706083463;1089.0742868561817;1093.573506332531;1133.0538999934981;6072.8785424292155;6075.422834830684;6076.756929722762;6077.8480537986015;6087.512998960073;6442.9355706443275;6512.772052978218;6513.869722605521;6535.052417399545;6537.705803238866;6147.262328520606;6158.876822463526;6159.260888693296;6167.5682702210415;6168;3482.8606855725993;3518.859245630197;3523.1544429337287;3525.8765943191866;3525.9294814103573;6627.801165965029;6659.433948114464;6786.389224969677;6798.252192258848;6840.828979275558;6729.932700672931;6747;6759.628220447824;6763.7632682855865;6771.052052712625;6778.152730908637;6812.114425124702;6819.761308354184;6820.249772525019;6823.965880170567;6563.442107420732;6563.835904102436;6570.737170513126;6571.112899758663;6576.177977752781;6301.558890877594;6454.903176452451;6474.061261117017;6482.448991835747;6489.059086432347;6768.763093291711;6811.591304521745;6811.931880681328;6815.93184068153;6822.283660215804;4484.730916144911;4525.479569849509;4528;4528.6377089833395;4531.025829446685;6607.900881486686;6618.470522358103;6646.102776125162;6647.534672573067;6648.069270302065;6252.374762523711;6381.042843573501;6387.393197646216;6388;6398.328175541501;6406.391392817675;6411.3909178627955;6432.839179020562;6442.194725659293;6480.254770701241;6302.9684851577285;6303.36966303366;6308.432241098323;6309.242890852944;6310.495160387066;6478.449331806661;6487.967560162169;6495.220573531206;6499.1876015498065;6503.057056726653;6045.1234570987845;6153.815385538441;6295.685215739286;6302.369763023661;6304.65324407162 13:06:47 INFO - PROCESS | 15798 | |5;yui.html;778.996105019475;791.5290402210683;807.2774866494491;844.7676888855568;873.663639498793;13401.46394144233;13580.524681636145;13586.456541738318;13612.523561675343;13614.251216183118;12534.247945123276;12658.430370633321;12659.746805063893;12660.240385576872;12671.113022088457;756.0926887734713;903.905089965554;905.7554460295717;929.1591110045385;931.7251410833786;917.651292508849;921.0697195832224;926.9907300926972;927.5594092805896;928.0348437624862;971.9805603887918;972.5963725054094;974.7270764186039;975.4781192062248;975.8926518083006;781.9413543984195;974.2352253481018;989.9455529945886;994.2046362909715;995.955182016811;710.5026481462996;712.8111050571603;713.3508507258422;713.668144312897;713.8750718624271;14121.15273083608;14137.575872723732;14186.290685465685;14195.574132776033;14198;13691.657708557266;14066.859331406657;14083.155010699391;14089.859101408958;14324.068935519263;10378.11785998191;11144.554217831277;11204.21570490066;11224.607138750187;11379;3910.824012919397;3969.7221194516396;3972.960270397317;3974.1654252606986;3995.880123596297;53798;54458.18312725312;55139.44860551423;55178.17232741512;55909.16136258;11081.168912331608;11190.776184476264;11281.774364512663;11320.320780753182;11554.884451155382;19649.508762281057;19657.508562286057;19657.803421965884;19672.409827705193;19675.90162049209;7621.082975075216;7736;7764.767056988299;8501.19238672325;8521.36089793268;4583.793729282191;4666.60333871618;4694.108119457293;4737.24204127338;4754.904901901942;3226.0805670384298;3243.9675603243663;3257.03917344384;3261.9836900815817;3262.9836850815595;577.5870252769206;591.1841658511227;629.9275583307887;664.5414663881907;678.6064082831946;606.0212756398384;638.4222278837659;653.921529416473;662.9270780214173;663.8406782372195;8080.636371363303;8175.83648327042;8660.090690477535;8752.56237188138;8825.91174088251;504.17818955102945;511.9820806271763;524.3471877512445;614.9108379284978;653.0498125227782;3911.002694312932;3947.072437977073;3967.504061992251;3973.403989401555;4033.495813023372;61941.38058619356;62506.37493625096;62542.687286563276;62601.686991565664;62877.68561157165;54748;54933.725331373884;55796;56618.716906416026;56656.71671641615;49334;49684.75157624261;50091.49908500941;50200;51106.23340649819;7981.321587664881;8154.1030486647605;8177.304929080857;8267.659478773692;8379.748607541784;38615.2276954465;38941;39373;39759.80120099381;40244.79877600593;48085.51914480951;49110.77223069452;49223;50085.24872126848;50244.49755502398;10119.696409107739;10222.693319200436;10451.16390688728;10612.0449159576;11035.944820275847;10903.752783467346;10915.508802103766;11006.889931100906;11269.943650282024;11383.772324553629;9592.712218633453;11610.94194529022;11692.883071169179;11715.589954351557;12054.939725301669;11197.160212983896;11492;11532.308061516336;11671.649850504498;11812.586559470377;11340.94329528347;11346.262492937933;11350.772984540428;11489.712757181138;11655.30068195911;9618.951905240428;9787.21702263803;9942.105210531086;10027.348222365523;10030.749231269278;9701.951490242503;9947.353422027545;9949.950250248703;10348;10349.534270957674 13:06:47 INFO - PROCESS | 15798 | __end_tp_report 13:06:47 INFO - PROCESS | 15798 | __start_cc_report 13:06:47 INFO - PROCESS | 15798 | _x_x_mozilla_cycle_collect,846 13:06:47 INFO - PROCESS | 15798 | __end_cc_report 13:06:47 INFO - PROCESS | 15798 | __startTimestamp1458072407792__endTimestamp 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | ------- Summary: start ------- 13:06:47 INFO - PROCESS | 15798 | Number of tests: 6 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#0] dojo.html Cycles:165 Average:5358.29 Median:5594.61 stddev:593.08 (10.6%) stddev-sans-first:570.32 13:06:47 INFO - PROCESS | 15798 | Values: 3204.4 3260.3 3270.8 3281.6 3298.6 5276.4 5297.7 5308.6 5322.0 5322.3 5287.9 5318.0 5322.8 5345.7 5347.7 4761.2 4868.7 4874.0 4918.5 4977.2 4776.1 4798.6 4855.7 4858.2 4858.9 4786.1 4970.0 4982.3 5011.5 5057.2 4974.5 4988.9 5006.9 5009.4 5036.1 4478.6 4835.3 4860.4 4894.1 4916.9 5159.6 5168.9 5189.8 5230.6 5236.6 5529.9 5628.5 5708.7 5770.2 5781.7 5725.8 5757.3 5793.4 5796.8 5834.8 5364.1 5369.0 5374.1 5394.5 5395.8 5740.2 5870.1 5870.4 5892.2 5986.0 5722.8 5728.1 5728.4 5733.0 5767.4 5769.5 5774.0 5776.9 5777.7 5798.6 5556.5 5737.0 5751.1 5758.1 5796.4 5810.2 5810.5 5815.0 5829.0 5835.0 4408.5 4426.3 4436.8 4456.1 4475.6 3906.1 3946.2 3976.8 4006.2 4032.5 5454.0 5478.4 5482.3 5485.8 5487.7 5788.1 5809.8 5814.7 5826.2 5859.1 5310.9 5455.6 5468.9 5478.4 5530.5 4991.7 5007.3 5012.6 5021.5 5052.9 5756.5 5975.9 5982.6 5990.5 6017.5 5803.2 5826.9 5856.0 5860.1 5869.0 5947.3 5954.6 5960.5 5965.4 5976.5 5547.5 5647.1 5719.1 5723.4 5723.6 5743.9 5777.6 5784.5 5784.7 5819.7 5634.7 5636.9 5637.4 5640.2 5642.8 5442.0 5582.3 5594.6 5619.9 5638.9 5588.4 5597.0 5597.2 5597.6 5603.1 5639.3 5702.5 5709.3 5738.3 5744.4 5410.9 5598.4 5639.5 5652.2 5664.7 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#1] ext.html Cycles:180 Average:45531.92 Median:38134.33 stddev:73685.78 (193.2%) stddev-sans-first:73815.11 13:06:47 INFO - PROCESS | 15798 | Values: 555.1 576.7 578.3 641.2 647.9 38990.0 39962.8 39979.2 39985.0 39991.4 43334.1 43904.3 43934.1 43942.3 44000.0 8868.9 9079.1 9081.3 9088.3 9091.4 8895.8 9034.2 9047.1 9048.5 9051.7 9246.4 9326.2 9328.7 9359.9 9361.0 9207.4 9270.0 9286.3 9287.6 9289.2 9150.5 9274.5 9280.9 9282.2 9283.4 43146.0 43553.8 43634.0 43679.6 43681.3 3753.9 3802.2 3833.8 3970.4 4299.2 32820.0 32973.3 33207.3 33304.5 33386.5 3623.1 3691.4 3750.6 3780.5 3809.9 274645.0 275365.0 275392.0 276004.0 276190.0 48965.8 62292.4 62317.0 62621.7 62639.7 47019.0 47248.8 47284.3 47333.5 47419.8 16693.7 16994.2 17027.2 17043.8 17051.1 12421.3 12568.2 12572.7 12574.2 12584.5 15580.5 15588.5 15633.8 15641.0 15654.8 6162.6 6208.9 6262.7 6342.7 6343.7 1061.8 1069.6 1091.2 1094.6 1134.8 30281.0 30387.7 30929.4 30980.8 31111.7 1135.7 1151.7 1156.1 1163.2 1180.3 15655.7 15823.5 15932.2 16392.5 16445.8 343823.0 348102.0 350571.0 350898.0 351168.0 57096.0 57249.7 57589.0 57806.7 57855.0 1360.3 1401.1 1456.2 1458.9 1478.4 29960.6 30001.4 30001.5 30243.5 30567.5 46644.5 47162.8 47341.0 47341.5 47352.0 200527.0 201578.0 201979.0 202083.0 202920.0 30333.0 34645.0 35033.3 35096.0 35229.8 43743.1 44956.3 45082.3 45121.1 45295.8 38121.6 38132.2 38202.8 38515.0 38646.6 37369.1 37502.4 38234.8 38621.8 38954.6 38136.4 38396.6 38668.8 38912.4 39017.0 33098.8 33744.3 33838.7 34429.3 34965.5 26536.2 26544.5 26745.4 26845.6 26900.9 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#2] jquery.html Cycles:180 Average:17721.01 Median:2507.04 stddev:29181.12 (1164.0%) stddev-sans-first:29233.90 13:06:47 INFO - PROCESS | 15798 | Values: 370.3 373.0 377.0 391.8 395.3 17844.4 18574.6 19041.9 19398.9 19405.2 17095.1 17223.0 17806.6 17815.9 17831.7 5018.9 5099.2 5146.0 5152.9 5159.5 3979.2 4993.8 5286.6 5493.0 5518.9 5515.5 5516.3 5530.1 5530.1 5538.8 5484.5 5713.7 5954.9 6108.8 6125.1 5372.6 5374.7 5377.6 5379.5 5386.1 20434.8 21293.8 21887.2 21923.2 21924.8 2467.9 2486.8 2527.3 2543.8 2961.8 9609.4 9632.6 9674.4 9779.1 9919.6 1998.5 2025.9 2047.1 2070.2 2076.7 62285.4 62512.4 62749.4 62860.4 63159.0 10154.8 10258.2 10269.0 10280.9 10304.4 13212.8 13298.4 13305.6 13314.9 13339.8 7694.8 7928.6 7934.0 8010.4 8025.4 7915.6 7958.1 7964.3 8012.0 8070.8 4287.7 4369.9 4625.6 4627.9 4704.5 1704.1 1750.8 1808.6 1828.1 1833.8 965.4 1035.3 1043.4 1053.1 1103.9 16653.9 16713.8 16920.6 17015.3 17194.0 909.9 1008.3 1036.2 1041.6 1111.0 9821.8 10065.7 10073.6 10086.1 10144.5 161332.0 161947.2 162074.2 162311.0 162697.0 72401.0 73982.6 74258.0 74280.3 75344.6 1047.2 1053.6 1058.6 1064.0 1080.3 15456.6 15476.4 15573.0 15960.4 16338.4 31913.5 33490.5 33659.0 33710.8 33978.0 38977.0 40889.6 42863.0 43750.8 44041.3 8316.3 8421.9 8437.2 8607.3 8684.1 8710.6 11875.6 13136.1 13196.5 13266.9 8985.8 10098.5 11285.6 11325.0 11440.4 10706.0 10950.6 11062.1 11163.6 11447.5 10733.4 10773.9 11079.4 11340.1 11600.2 8144.9 8389.4 8460.4 8476.4 8708.3 8486.0 10912.9 11336.7 11424.3 11443.8 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#3] mootools.html Cycles:180 Average:5954.63 Median:5261.96 stddev:3205.74 (60.9%) stddev-sans-first:3196.67 13:06:47 INFO - PROCESS | 15798 | Values: 1427.4 1574.8 1593.1 1851.4 1966.3 7491.5 7975.8 8063.8 8072.7 8090.8 8383.9 8536.4 8559.5 8569.8 8580.9 2082.6 2131.3 2366.8 2374.5 2396.5 2403.7 2414.2 2417.2 2417.5 2420.8 2240.4 2301.5 2367.2 2367.9 2368.6 2342.0 2350.0 2364.1 2429.7 2433.6 2376.6 2378.6 2381.1 2384.9 2463.0 8227.5 8256.0 8262.6 8264.0 8276.0 5113.7 5236.7 5274.6 5276.9 5277.2 3128.2 3159.3 3181.5 3186.0 3211.8 904.2 905.0 994.5 1006.4 1031.6 12240.3 12356.6 12368.6 12374.7 12389.3 4503.8 4603.3 4636.0 4642.3 4670.8 10511.1 10547.9 10556.9 10561.0 10573.7 5246.6 5257.2 5258.3 5259.9 5264.0 4087.1 4518.9 4609.4 4640.7 4650.4 3912.2 3934.2 3992.9 4005.4 4042.2 1197.7 1235.1 1241.6 1254.5 1280.4 1221.7 1250.8 1260.9 1512.2 1515.9 8060.4 8286.8 8333.3 8336.7 8339.7 507.8 508.6 508.9 510.9 520.1 5996.5 6051.4 6051.8 6090.8 6101.8 9908.3 10215.8 10269.6 10284.1 10295.6 9831.4 10073.9 10122.2 10127.3 10139.7 8094.5 8134.9 8224.3 8232.0 8245.7 7873.8 8011.2 8055.6 8073.2 8162.9 9043.2 9190.6 9216.8 9241.7 9373.3 9413.8 9538.7 9546.8 9747.9 9959.7 6621.6 7386.4 7674.0 7753.8 7899.2 8238.1 8246.0 8268.3 8300.0 8300.4 7104.4 7273.9 7371.3 7420.0 7676.8 7286.9 7290.4 7372.9 7399.9 7483.5 7698.7 7764.7 7764.8 7869.2 7959.1 7189.4 7214.8 7262.2 7267.9 7350.4 7120.2 7232.6 7268.3 7284.4 7292.2 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#4] prototype.html Cycles:180 Average:5319.11 Median:6066.41 stddev:1602.74 (26.4%) stddev-sans-first:1563.27 13:06:47 INFO - PROCESS | 15798 | Values: 351.6 351.9 358.8 361.6 362.1 5983.1 6001.8 6017.4 6054.5 6059.9 5929.5 5930.5 5932.1 5941.7 5943.0 4476.6 4544.1 4590.3 4609.7 4654.3 4651.8 4653.9 4658.4 4659.4 4669.7 4619.5 4620.2 4626.3 4629.2 4632.1 4457.0 4470.2 4564.7 4565.4 4579.0 4048.8 4050.5 4052.6 4055.5 4077.8 5627.9 5629.8 5629.9 5630.4 5635.9 5336.6 5339.0 5340.7 5342.2 5343.9 6216.9 6240.2 6240.9 6241.2 6246.3 4317.1 4472.4 4477.4 4485.0 4487.9 6536.9 6628.1 6634.6 6639.5 6645.4 4428.4 4433.0 4434.3 4438.2 4456.7 4483.8 4485.4 4486.3 4489.9 4496.1 5204.1 5208.3 5210.8 5211.7 5225.9 6188.2 6266.7 6310.8 6318.6 6318.9 1580.8 1595.1 1599.5 1605.0 1606.5 1024.9 1080.5 1089.1 1093.6 1133.1 6072.9 6075.4 6076.8 6077.8 6087.5 6442.9 6512.8 6513.9 6535.1 6537.7 6147.3 6158.9 6159.3 6167.6 6168.0 3482.9 3518.9 3523.2 3525.9 3525.9 6627.8 6659.4 6786.4 6798.3 6840.8 6729.9 6747.0 6759.6 6763.8 6771.1 6778.2 6812.1 6819.8 6820.2 6824.0 6563.4 6563.8 6570.7 6571.1 6576.2 6301.6 6454.9 6474.1 6482.4 6489.1 6768.8 6811.6 6811.9 6815.9 6822.3 4484.7 4525.5 4528.0 4528.6 4531.0 6607.9 6618.5 6646.1 6647.5 6648.1 6252.4 6381.0 6387.4 6388.0 6398.3 6406.4 6411.4 6432.8 6442.2 6480.3 6303.0 6303.4 6308.4 6309.2 6310.5 6478.4 6488.0 6495.2 6499.2 6503.1 6045.1 6153.8 6295.7 6302.4 6304.7 13:06:47 INFO - PROCESS | 15798 | 13:06:47 INFO - PROCESS | 15798 | [#5] yui.html Cycles:180 Average:14775.37 Median:49278.50 stddev:17642.74 (35.8%) stddev-sans-first:17660.93 13:06:47 INFO - PROCESS | 15798 | Values: 779.0 791.5 807.3 844.8 873.7 13401.5 13580.5 13586.5 13612.5 13614.3 12534.2 12658.4 12659.7 12660.2 12671.1 756.1 903.9 905.8 929.2 931.7 917.7 921.1 927.0 927.6 928.0 972.0 972.6 974.7 975.5 975.9 781.9 974.2 989.9 994.2 996.0 710.5 712.8 713.4 713.7 713.9 14121.2 14137.6 14186.3 14195.6 14198.0 13691.7 14066.9 14083.2 14089.9 14324.1 10378.1 11144.6 11204.2 11224.6 11379.0 3910.8 3969.7 3973.0 3974.2 3995.9 53798.0 54458.2 55139.4 55178.2 55909.2 11081.2 11190.8 11281.8 11320.3 11554.9 19649.5 19657.5 19657.8 19672.4 19675.9 7621.1 7736.0 7764.8 8501.2 8521.4 4583.8 4666.6 4694.1 4737.2 4754.9 3226.1 3244.0 3257.0 3262.0 3263.0 577.6 591.2 629.9 664.5 678.6 606.0 638.4 653.9 662.9 663.8 8080.6 8175.8 8660.1 8752.6 8825.9 504.2 512.0 524.3 614.9 653.0 3911.0 3947.1 3967.5 3973.4 4033.5 61941.4 62506.4 62542.7 62601.7 62877.7 54748.0 54933.7 55796.0 56618.7 56656.7 49334.0 49684.8 50091.5 50200.0 51106.2 7981.3 8154.1 8177.3 8267.7 8379.7 38615.2 38941.0 39373.0 39759.8 40244.8 48085.5 49110.8 49223.0 50085.2 50244.5 10119.7 10222.7 10451.2 10612.0 11035.9 10903.8 10915.5 11006.9 11269.9 11383.8 9592.7 11610.9 11692.9 11715.6 12054.9 11197.2 11492.0 11532.3 11671.6 11812.6 11340.9 11346.3 11350.8 11489.7 11655.3 9619.0 9787.2 9942.1 10027.3 10030.7 9702.0 9947.4 9950.0 10348.0 10349.5 13:06:47 INFO - PROCESS | 15798 | -------- Summary: end -------- 13:06:47 INFO - PROCESS | 15798 | 13:06:48 INFO - TEST-INFO | 15798: exit 0 13:06:48 INFO - TEST-OK | dromaeo_css | took 1111739ms 13:06:48 INFO - TEST-START | kraken 13:06:48 INFO - operating with platform_type : linux_ 13:06:48 INFO - Initialising browser for kraken test... 13:06:48 INFO - TEST-INFO | started process 15988 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIkse7m/profile http://localhost:45160/getInfo.html) 13:06:52 INFO - PROCESS | 15988 | __metrics Screen width/height:1600/1200 13:06:52 INFO - PROCESS | 15988 | colorDepth:24 13:06:52 INFO - PROCESS | 15988 | Browser inner width/height: 1024/697 13:06:52 INFO - PROCESS | 15988 | __metrics 13:06:53 INFO - PROCESS | 15988 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:06:54 INFO - TEST-INFO | 15988: exit 0 13:06:54 INFO - Browser initialized. 13:06:54 INFO - Running cycle 1/1 for kraken test... 13:06:54 INFO - TEST-INFO | started process 16077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIkse7m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:06 INFO - PROCESS | 16077 | RSS: Main: 144973824 13:07:06 INFO - PROCESS | 16077 | 13:07:08 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:09 INFO - PROCESS | 16077 | RSS: Main: 181047296 13:07:09 INFO - PROCESS | 16077 | 13:07:12 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-dft) 13:07:12 INFO - PROCESS | 16077 | RSS: Main: 178941952 13:07:12 INFO - PROCESS | 16077 | 13:07:15 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-fft) 13:07:16 INFO - PROCESS | 16077 | RSS: Main: 174624768 13:07:16 INFO - PROCESS | 16077 | 13:07:18 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45160/tests/kraken/driver.html?testName=audio-oscillator) 13:07:18 INFO - PROCESS | 16077 | RSS: Main: 174882816 13:07:18 INFO - PROCESS | 16077 | 13:07:20 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:21 INFO - PROCESS | 16077 | RSS: Main: 172580864 13:07:21 INFO - PROCESS | 16077 | 13:07:24 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:24 INFO - PROCESS | 16077 | RSS: Main: 172904448 13:07:24 INFO - PROCESS | 16077 | 13:07:28 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45160/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:28 INFO - PROCESS | 16077 | RSS: Main: 173240320 13:07:28 INFO - PROCESS | 16077 | 13:07:31 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45160/tests/kraken/driver.html?testName=json-parse-financial) 13:07:32 INFO - PROCESS | 16077 | RSS: Main: 172163072 13:07:32 INFO - PROCESS | 16077 | 13:07:33 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:34 INFO - PROCESS | 16077 | RSS: Main: 177328128 13:07:34 INFO - PROCESS | 16077 | 13:07:36 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:36 INFO - PROCESS | 16077 | RSS: Main: 175341568 13:07:36 INFO - PROCESS | 16077 | 13:07:38 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:39 INFO - PROCESS | 16077 | RSS: Main: 182792192 13:07:39 INFO - PROCESS | 16077 | 13:07:41 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:42 INFO - PROCESS | 16077 | RSS: Main: 188096512 13:07:42 INFO - PROCESS | 16077 | 13:07:44 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:45 INFO - PROCESS | 16077 | RSS: Main: 187637760 13:07:45 INFO - PROCESS | 16077 | 13:07:46 INFO - PROCESS | 16077 | Cycle 1(1): loaded http://localhost:45160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45160/tests/kraken/driver.html?testName=ai-astar) 13:07:47 INFO - PROCESS | 16077 | RSS: Main: 248061952 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | __start_tp_report 13:07:47 INFO - PROCESS | 16077 | _x_x_mozilla_page_load 13:07:47 INFO - PROCESS | 16077 | _x_x_mozilla_page_load_details 13:07:47 INFO - PROCESS | 16077 | |i|pagename|runs| 13:07:47 INFO - PROCESS | 16077 | |0;ai-astar;110;111;104;109;111;110;98;108;110;108 13:07:47 INFO - PROCESS | 16077 | |1;audio-beat-detection;155;126;151;174;127;151;148;128;169;127 13:07:47 INFO - PROCESS | 16077 | |2;audio-dft;160;159;160;160;164;160;159;163;161;161 13:07:47 INFO - PROCESS | 16077 | |3;audio-fft;76;75;75;155;74;76;73;76;157;75 13:07:47 INFO - PROCESS | 16077 | |4;audio-oscillator;94;93;148;92;93;93;137;92;93;137 13:07:47 INFO - PROCESS | 16077 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;117;116 13:07:47 INFO - PROCESS | 16077 | |6;imaging-darkroom;145;147;146;146;146;145;145;146;146;145 13:07:47 INFO - PROCESS | 16077 | |7;imaging-desaturate;96;96;96;95;96;96;96;95;96;96 13:07:47 INFO - PROCESS | 16077 | |8;json-parse-financial;56;58;57;56;57;56;58;63;55;54 13:07:47 INFO - PROCESS | 16077 | |9;json-stringify-tinderbox;64;64;65;65;65;65;65;65;64;65 13:07:47 INFO - PROCESS | 16077 | |10;stanford-crypto-aes;77;79;79;79;79;79;78;79;79;78 13:07:47 INFO - PROCESS | 16077 | |11;stanford-crypto-ccm;119;112;116;111;117;113;108;113;109;110 13:07:47 INFO - PROCESS | 16077 | |12;stanford-crypto-pbkdf2;144;135;144;147;157;143;138;144;134;138 13:07:47 INFO - PROCESS | 16077 | |13;stanford-crypto-sha256-iterative;66;68;71;67;69;69;65;67;64;67 13:07:47 INFO - PROCESS | 16077 | __end_tp_report 13:07:47 INFO - PROCESS | 16077 | __start_cc_report 13:07:47 INFO - PROCESS | 16077 | _x_x_mozilla_cycle_collect,1040 13:07:47 INFO - PROCESS | 16077 | __end_cc_report 13:07:47 INFO - PROCESS | 16077 | __startTimestamp1458072467092__endTimestamp 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | ------- Summary: start ------- 13:07:47 INFO - PROCESS | 16077 | Number of tests: 14 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:4.04 (3.7%) stddev-sans-first:4.21 13:07:47 INFO - PROCESS | 16077 | Values: 110.0 111.0 104.0 109.0 111.0 110.0 98.0 108.0 110.0 108.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:151.00 stddev:17.93 (11.9%) stddev-sans-first:18.69 13:07:47 INFO - PROCESS | 16077 | Values: 155.0 126.0 151.0 174.0 127.0 151.0 148.0 128.0 169.0 127.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.64 (1.0%) stddev-sans-first:1.72 13:07:47 INFO - PROCESS | 16077 | Values: 160.0 159.0 160.0 160.0 164.0 160.0 159.0 163.0 161.0 161.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#3] audio-fft Cycles:10 Average:91.20 Median:75.00 stddev:34.17 (45.6%) stddev-sans-first:35.80 13:07:47 INFO - PROCESS | 16077 | Values: 76.0 75.0 75.0 155.0 74.0 76.0 73.0 76.0 157.0 75.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.29 (25.0%) stddev-sans-first:24.21 13:07:47 INFO - PROCESS | 16077 | Values: 94.0 93.0 148.0 92.0 93.0 93.0 137.0 92.0 93.0 137.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:07:47 INFO - PROCESS | 16077 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:07:47 INFO - PROCESS | 16077 | Values: 145.0 147.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:07:47 INFO - PROCESS | 16077 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.45 (4.3%) stddev-sans-first:2.57 13:07:47 INFO - PROCESS | 16077 | Values: 56.0 58.0 57.0 56.0 57.0 56.0 58.0 63.0 55.0 54.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 13:07:47 INFO - PROCESS | 16077 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.44 13:07:47 INFO - PROCESS | 16077 | Values: 77.0 79.0 79.0 79.0 79.0 79.0 78.0 79.0 79.0 78.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:113.00 stddev:3.58 (3.2%) stddev-sans-first:3.02 13:07:47 INFO - PROCESS | 16077 | Values: 119.0 112.0 116.0 111.0 117.0 113.0 108.0 113.0 109.0 110.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.00 stddev:6.72 (4.7%) stddev-sans-first:7.10 13:07:47 INFO - PROCESS | 16077 | Values: 144.0 135.0 144.0 147.0 157.0 143.0 138.0 144.0 134.0 138.0 13:07:47 INFO - PROCESS | 16077 | 13:07:47 INFO - PROCESS | 16077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.06 (3.0%) stddev-sans-first:2.13 13:07:47 INFO - PROCESS | 16077 | Values: 66.0 68.0 71.0 67.0 69.0 69.0 65.0 67.0 64.0 67.0 13:07:47 INFO - PROCESS | 16077 | -------- Summary: end -------- 13:07:47 INFO - PROCESS | 16077 | 13:07:48 INFO - TEST-INFO | 16077: exit 0 13:07:48 INFO - TEST-OK | kraken | took 59525ms 13:07:48 INFO - SUITE-END | took 1171s 13:07:48 INFO - Completed test suite (00:19:31) 13:07:48 INFO - javascript benchmark 13:07:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3204.359128174365, 3260.250142467234, 3270.8037517748935, 3281.5898012748407, 3298.587676540432, 5276.419593844674, 5297.735113244342, 5308.628396012281, 5321.973390133049, 5322.308099947001, 5287.920681189786, 5318.042752304594, 5322.8137015204475, 5345.7059861707685, 5347.679139251638, 4761.190597598416, 4868.659193856432, 4873.951260487394, 4918.5327393897705, 4977.203647416414, 4776.140294746944, 4798.568128868401, 4855.660103792736, 4858.174110401223, 4858.927116093261, 4786.066716990188, 4970.030843985406, 4982.2526621006955, 5011.548960593545, 5057.190849464087, 4974.4528101908945, 4988.8503344899345, 5006.899862002776, 5009.4239162496415, 5036.093503169446, 4478.57453541913, 4835.298881662175, 4860.441049279343, 4894.119058569456, 4916.901661966741, 5159.638825282232, 5168.9224661630105, 5189.766460509286, 5230.607704422146, 5236.633435659505, 5529.889402211974, 5628.521575666074, 5708.686022268774, 5770.2498675171955, 5781.71091445426, 5725.799597014085, 5757.251557297566, 5793.449622285876, 5796.797112101099, 5834.824955251349, 5364.088105022156, 5368.973155134199, 5374.086405311106, 5394.487523685244, 5395.81114660985, 5740.167675687002, 5870.0607902735355, 5870.412958704095, 5892.234009578728, 5986.0, 5722.77108915647, 5728.05487094633, 5728.398518155617, 5733.025385684444, 5767.394423585463, 5769.538436925036, 5774.0, 5776.855578610484, 5777.653340799566, 5798.565107616945, 5556.472135147154, 5737.0, 5751.051076572402, 5758.078707406795, 5796.449337312949, 5810.215620891126, 5810.5061069809535, 5815.040518314515, 5828.970855145697, 5835.0, 4408.53710360414, 4426.26966550522, 4436.800343984529, 4456.131054444352, 4475.552444755564, 3906.121122747359, 3946.1515774108702, 3976.848208326286, 4006.2187873364414, 4032.516098068251, 5454.045542030208, 5478.397376288605, 5482.314710661168, 5485.753141108659, 5487.670739755627, 5788.131780232999, 5809.82570522885, 5814.651120932757, 5826.242588463472, 5859.121131830174, 5310.92033619496, 5455.5908306877145, 5468.945310546923, 5478.397376288605, 5530.474604912527, 4991.725455099931, 5007.298978143063, 5012.598992080625, 5021.49785021495, 5052.873678158076, 5756.481916627524, 5975.880482390415, 5982.551308651869, 5990.520758339322, 6017.518598512196, 5803.187553742564, 5826.883462330815, 5855.975204339309, 5860.09168578871, 5868.970655146697, 5947.316058653138, 5954.642721436728, 5960.4635582797755, 5965.403459654, 5976.462118409364, 5547.528460080938, 5647.124695672013, 5719.113537401709, 5723.399043100415, 5723.627964182315, 5743.908657355256, 5777.566682498914, 5784.479396854304, 5784.739686714024, 5819.738111784895, 5634.661920284796, 5636.887262254814, 5637.351704554028, 5640.238567793295, 5642.774289028557, 5442.047641662614, 5582.302212223472, 5594.608377413542, 5619.904118696978, 5638.9436105638415, 5588.3573389060775, 5597.0, 5597.160425936142, 5597.63615365, 5603.131514615241, 5639.2668953035845, 5702.486776190163, 5709.25779648643, 5738.340090889601, 5744.368119506935, 5410.864728381822, 5598.412166722435, 5639.492445679908, 5652.180433836988, 5664.688442135557], "unit": "score", "name": "dojo.html", "value": 5320.238969154472}, {"lowerIsBetter": false, "replicates": [555.0841112164925, 576.7433492096019, 578.3031447106238, 641.2017038786711, 647.8509942713177, 38990.0, 39962.80018599907, 39979.20041599166, 39985.0, 39991.40012899809, 43334.13331733363, 43904.3414348785, 43934.12131757363, 43942.34086488705, 44000.0, 8868.911310886906, 9079.137481939206, 9081.273498120134, 9088.318376121817, 9091.363604547685, 8895.822083558325, 9034.186923176912, 9047.140521650434, 9048.502332371718, 9051.683191088314, 9246.398984066047, 9326.1606455419, 9328.673496427626, 9359.906400936006, 9361.0, 9207.4475531468, 9270.026647202081, 9286.257099432029, 9287.628494860197, 9289.163975242227, 9150.450972941644, 9274.53627318638, 9280.907190928072, 9282.164605185566, 9283.39657922233, 43146.0, 43553.78223108896, 43634.0, 43679.56320436787, 43681.34477982833, 3753.906152346186, 3802.182530755873, 3833.769973801581, 3970.4242884781834, 4299.204647140289, 32820.0, 32973.34053318944, 33207.3358532828, 33304.50043249353, 33386.49920251198, 3623.148560088377, 3691.354013047706, 3750.6436888495823, 3780.546334439885, 3809.923801523954, 274645.0, 275365.0, 275392.0, 276004.0, 276190.0, 48965.755171223915, 62292.37707622956, 62317.0, 62621.68689156525, 62639.68680156661, 47019.0, 47248.76375618169, 47284.29073563899, 47333.5266647336, 47419.76290118528, 16693.6661266774, 16994.150292485327, 17027.233774480177, 17043.82956170447, 17051.14744262782, 12421.254724716366, 12568.183068100545, 12572.685682858002, 12574.182678125893, 12584.496620135274, 15580.532584022498, 15588.454404095803, 15633.843661563466, 15641.0, 15654.843451565339, 6162.599431037058, 6208.85794400931, 6262.749490020439, 6342.651154186564, 6343.714532846033, 1061.7557961668858, 1069.6149386220955, 1091.2088735666578, 1094.6059418609295, 1134.846795682589, 30281.0, 30387.696123038928, 30929.381412371626, 30980.84509577483, 31111.688883111332, 1135.6990397544657, 1151.746615744535, 1156.0578228576073, 1163.1973937982764, 1180.2741314091943, 15655.68688626244, 15823.525294241192, 15932.203389830695, 16392.508224753277, 16445.835541644432, 343823.0, 348102.0, 350571.0, 350898.0, 351168.0, 57096.0, 57249.71001159907, 57589.0, 57806.7109664449, 57855.0, 1360.2586590308306, 1401.1102949627061, 1456.2281990545027, 1458.912465252067, 1478.4012474947663, 29960.550591740706, 30001.399972000876, 30001.549976750804, 30243.546346804374, 30567.54148687816, 46644.53355466402, 47162.76418617885, 47341.0, 47341.526584733714, 47352.0, 200527.0, 201578.0, 201979.0, 202083.0, 202920.0, 30333.0, 34645.0, 35033.29933401369, 35096.0, 35229.82385088058, 43743.12513749771, 44956.325655115856, 45082.3237651442, 45121.0975780476, 45295.773521132185, 38121.61878381292, 38132.237355253295, 38202.80898595489, 38515.0, 38646.6135338643, 37369.082946857394, 37502.43746343862, 38234.80882595569, 38621.80689096649, 38954.6104538951, 38136.427953581275, 38396.61603384042, 38668.80665596654, 38912.41631375588, 39017.02457438587, 33098.83450582732, 33744.32511349808, 33838.66161338454, 34429.311413772084, 34965.47551786674, 26536.203913882615, 26544.469110618065, 26745.408385893526, 26845.597316040665, 26900.865495672395], "unit": "score", "name": "ext.html", "value": 18927.21851018441}, {"lowerIsBetter": false, "replicates": [370.3315515494532, 372.9757565758224, 376.95288088988895, 391.7668986952763, 395.25297188314073, 17844.37544685936, 18574.628507429843, 19041.904790476063, 19398.903005484986, 19405.22379104838, 17095.145242737875, 17223.0, 17806.554836129104, 17815.910920445378, 17831.73252401215, 5018.949810501894, 5099.184130539114, 5145.974270128644, 5152.948470515303, 5159.535641792238, 3979.1842672252264, 4993.75031248438, 5286.577073834103, 5493.0, 5518.862028449301, 5515.531179849698, 5516.255305533742, 5530.087535556629, 5530.087535556629, 5538.75075621598, 5484.506394424501, 5713.71431428429, 5954.8809023819285, 6108.816735497942, 6125.081237814341, 5372.570194384479, 5374.677519348813, 5377.569794416438, 5379.488948549882, 5386.111291636876, 20434.795652043587, 21293.787062129337, 21887.233946811786, 21923.232686855885, 21924.780752192433, 2467.864267465289, 2486.76375744304, 2527.317624241463, 2543.758342957416, 2961.7778666600093, 9609.375390599658, 9632.614695412176, 9674.419534827934, 9779.070988256104, 9919.553620087114, 1998.4504261328252, 2025.878447293167, 2047.140201115535, 2070.2133189388087, 2076.719642848211, 62285.37714622841, 62512.37487625111, 62749.37250627481, 62860.37139628591, 63159.0, 10154.796904061877, 10258.17934565233, 10269.0, 10280.897191028143, 10304.433256170983, 13212.801807972888, 13298.401571929286, 13305.600831975056, 13314.93342533281, 13339.799903001463, 7694.846103077907, 7928.6035698214855, 7934.0, 8010.359171266285, 8025.357971362277, 7915.643796029192, 7958.124606293303, 7964.283214510722, 8011.959940200261, 8070.757877263692, 4287.656987440997, 4369.9126017479475, 4625.583697467244, 4627.907441851212, 4704.482506924235, 1704.1223769758585, 1750.798658154303, 1808.5840256741023, 1828.1316374722167, 1833.8166183381554, 965.3628605120587, 1035.2649618770606, 1043.4261156363968, 1053.1048608682559, 1103.9071319393743, 16653.91673041627, 16713.83286167147, 16920.57698557546, 17015.319387224372, 17194.0, 909.9454032758056, 1008.2790804574764, 1036.2021243642353, 1041.5521325829966, 1110.9722256943642, 9821.754456138653, 10065.69802905914, 10073.597056117673, 10086.142677872316, 10144.543495542719, 161332.0, 161947.19026404794, 162074.1896290511, 162311.0, 162697.0, 72401.0, 73982.6300868503, 74258.0, 74280.25719742733, 75344.62327688327, 1047.1570385839473, 1053.6154303679255, 1058.5765693722572, 1063.9627613033506, 1080.3247970018738, 15456.613584660474, 15476.380944762084, 15573.0, 15960.361585536448, 16338.428155014517, 31913.521297180097, 33490.497642534894, 33659.0, 33710.83144584261, 33978.0, 38977.0, 40889.59110408858, 42863.0, 43750.78124609357, 44041.339379908684, 8316.251537361666, 8421.873671894804, 8437.198466145706, 8607.268382187583, 8684.131586841266, 8710.564471776512, 11875.584354547549, 13136.146150500186, 13196.538121165713, 13266.933665331611, 8985.831841860516, 10098.49507524606, 11285.605003824827, 11325.037371823488, 11440.370779607201, 10706.0, 10950.616728414467, 11062.115030797679, 11163.609273675382, 11447.542098316308, 10733.409662468326, 10773.89226107729, 11079.390633515233, 11340.149488788209, 11600.245984011011, 8144.918550814416, 8389.412741108064, 8460.407771455939, 8476.449030812977, 8708.303335733253, 8486.0, 10912.945435272773, 11336.659900203007, 11424.314541127558, 11443.771124577628], "unit": "score", "name": "jquery.html", "value": 8376.84787704054}, {"lowerIsBetter": false, "replicates": [1427.37195633921, 1574.7716581095742, 1593.1237819199437, 1851.4260579220443, 1966.3117908731954, 7491.513051651639, 7975.800604984878, 8063.758087257377, 8072.677092916277, 8090.838183236332, 8383.91616083839, 8536.359773017017, 8559.486430814155, 8569.785755356104, 8580.871286930686, 2082.562661841015, 2131.328631481086, 2366.7869891709743, 2374.513224788914, 2396.4607963208227, 2403.723571789249, 2414.167112346238, 2417.226487523993, 2417.516496700658, 2420.7579242075826, 2240.406292332533, 2301.5166814968875, 2367.1951536477595, 2367.8816059197056, 2368.5736567417857, 2342.0, 2349.9765002349927, 2364.1016413762745, 2429.6598476213344, 2433.6349547568007, 2376.619740841457, 2378.6432035194684, 2381.071382160959, 2384.8569085854906, 2462.987685061581, 8227.465214761081, 8255.958720206361, 8262.586870656443, 8264.0, 8276.0, 5113.693178409308, 5236.7119808410525, 5274.551663108602, 5276.868078298035, 5277.155655095205, 3128.2179455136215, 3159.3207460395897, 3181.5068664357063, 3186.0282613802783, 3211.823349715765, 904.2449554621899, 905.0496978172893, 994.5126887824986, 1006.3559322033905, 1031.6440827914357, 12240.265584064895, 12356.62930112098, 12368.567100151451, 12374.690632734164, 12389.256644601353, 4503.842365517191, 4603.332516785047, 4635.95364046362, 4642.326862604903, 4670.789814458358, 10511.054005139422, 10547.894521054845, 10556.947215264028, 10561.049505544384, 10573.682789516326, 5246.632735708464, 5257.211418287287, 5258.2638430619745, 5259.921101183485, 5264.0, 4087.141700242982, 4518.932216016762, 4609.423822022247, 4640.677406939006, 4650.4186976627925, 3912.1784425270444, 3934.232824599233, 3992.8802135935966, 4005.399190121505, 4042.171354872244, 1197.6586672798385, 1235.0983781839127, 1241.6461308527028, 1254.4605819497522, 1280.3726174174774, 1221.7251118498446, 1250.8248845161684, 1260.9369531523387, 1512.2287633307092, 1515.9469418570297, 8060.355171586376, 8286.798414229903, 8333.291670207978, 8336.666533338599, 8339.708110216114, 507.8222622082242, 508.6210772974158, 508.92366145078535, 510.9182530795055, 520.10541867987, 5996.460318571262, 6051.364606716319, 6051.818445446644, 6090.842739879408, 6101.755929762849, 9908.256880733974, 10215.795684086277, 10269.640562580274, 10284.074433301039, 10295.639652612272, 9831.36096153762, 10073.899261007296, 10122.190224782, 10127.341722787995, 10139.695809125738, 8094.473859199134, 8134.877976830352, 8224.300934420522, 8231.95884020576, 8245.711400101087, 7873.763787086396, 8011.198880111942, 8055.597220139087, 8073.19268073188, 8162.918370816215, 9043.23132533742, 9190.632374704937, 9216.815663686555, 9241.676541321021, 9373.29700272496, 9413.811723765622, 9538.713838584854, 9546.761330966781, 9747.9025209747, 9959.651412200537, 6621.569597976116, 7386.372158366384, 7674.0, 7753.806154846174, 7899.249571290718, 8238.093809680811, 8245.95877020635, 8268.2558569729, 8300.0, 8300.418970671995, 7104.3961263293195, 7273.927260727325, 7371.336579707852, 7419.962900185465, 7676.846463070819, 7286.927130728837, 7290.380317672845, 7372.926270737224, 7399.852002959803, 7483.476156668981, 7698.730544430918, 7764.650590723544, 7764.84470310602, 7869.213078692085, 7959.124496305518, 7189.352958233784, 7214.819629509304, 7262.164851042197, 7267.927320726725, 7350.448716346403, 7120.2167761547225, 7232.566046037255, 7268.27317268269, 7284.417246620364, 7292.197858235696], "unit": "score", "name": "mootools.html", "value": 4745.634647430144}, {"lowerIsBetter": false, "replicates": [351.6290313719027, 351.8557391469495, 358.78831489421236, 361.6419744452991, 362.12727327141585, 5983.102534619809, 6001.789937352193, 6017.398260173981, 6054.5459090568165, 6059.939400605993, 5929.466348028676, 5930.495907847838, 5932.080527518242, 5941.673207973559, 5943.0, 4476.61948734358, 4544.136614043321, 4590.334401511779, 4609.654275929302, 4654.3251228571835, 4651.813927442899, 4653.86038418848, 4658.417697787777, 4659.394278743758, 4669.719816811003, 4619.491855895849, 4620.19146649335, 4626.282926146453, 4629.23617603095, 4632.119897219518, 4457.0, 4470.150671372445, 4564.726116433025, 4565.383673204108, 4578.9542104579195, 4048.7773172475504, 4050.51393832739, 4052.5542190359038, 4055.5133383993816, 4077.8368865245357, 5627.8593035174035, 5629.80295689653, 5629.8592535186535, 5630.380658127603, 5635.943640563582, 5336.626436149471, 5339.038972984861, 5340.652857564285, 5342.198670199462, 5343.893122137574, 6216.937830621681, 6240.188775459206, 6240.87518249637, 6241.188645476059, 6246.25044994599, 4317.093410383792, 4472.418585583853, 4477.417935668343, 4485.035717320759, 4487.865364039084, 6536.901946470807, 6628.138342015555, 6634.568753031086, 6639.502037347218, 6645.368689974444, 4428.4243048403505, 4433.046894917544, 4434.312681534368, 4438.245498265303, 4456.665750068758, 4483.843065492757, 4485.372047913294, 4486.304622783474, 4489.932651010237, 4496.078303947683, 5204.141316682705, 5208.296879921238, 5210.843674689765, 5211.661242019257, 5225.895482090337, 6188.226471691039, 6266.655333956585, 6310.8422289442215, 6318.62088274705, 6318.873622527523, 1580.8023997000375, 1595.114711335197, 1599.4881637876001, 1605.0, 1606.4618352851692, 1024.8513965475113, 1080.5461706083463, 1089.0742868561817, 1093.573506332531, 1133.0538999934981, 6072.8785424292155, 6075.422834830684, 6076.756929722762, 6077.8480537986015, 6087.512998960073, 6442.9355706443275, 6512.772052978218, 6513.869722605521, 6535.052417399545, 6537.705803238866, 6147.262328520606, 6158.876822463526, 6159.260888693296, 6167.5682702210415, 6168.0, 3482.8606855725993, 3518.859245630197, 3523.1544429337287, 3525.8765943191866, 3525.9294814103573, 6627.801165965029, 6659.433948114464, 6786.389224969677, 6798.252192258848, 6840.828979275558, 6729.932700672931, 6747.0, 6759.628220447824, 6763.7632682855865, 6771.052052712625, 6778.152730908637, 6812.114425124702, 6819.761308354184, 6820.249772525019, 6823.965880170567, 6563.442107420732, 6563.835904102436, 6570.737170513126, 6571.112899758663, 6576.177977752781, 6301.558890877594, 6454.903176452451, 6474.061261117017, 6482.448991835747, 6489.059086432347, 6768.763093291711, 6811.591304521745, 6811.931880681328, 6815.93184068153, 6822.283660215804, 4484.730916144911, 4525.479569849509, 4528.0, 4528.6377089833395, 4531.025829446685, 6607.900881486686, 6618.470522358103, 6646.102776125162, 6647.534672573067, 6648.069270302065, 6252.374762523711, 6381.042843573501, 6387.393197646216, 6388.0, 6398.328175541501, 6406.391392817675, 6411.3909178627955, 6432.839179020562, 6442.194725659293, 6480.254770701241, 6302.9684851577285, 6303.36966303366, 6308.432241098323, 6309.242890852944, 6310.495160387066, 6478.449331806661, 6487.967560162169, 6495.220573531206, 6499.1876015498065, 6503.057056726653, 6045.1234570987845, 6153.815385538441, 6295.685215739286, 6302.369763023661, 6304.65324407162], "unit": "score", "name": "prototype.html", "value": 4804.3255642920785}, {"lowerIsBetter": false, "replicates": [778.996105019475, 791.5290402210683, 807.2774866494491, 844.7676888855568, 873.663639498793, 13401.46394144233, 13580.524681636145, 13586.456541738318, 13612.523561675343, 13614.251216183118, 12534.247945123276, 12658.430370633321, 12659.746805063893, 12660.240385576872, 12671.113022088457, 756.0926887734713, 903.905089965554, 905.7554460295717, 929.1591110045385, 931.7251410833786, 917.651292508849, 921.0697195832224, 926.9907300926972, 927.5594092805896, 928.0348437624862, 971.9805603887918, 972.5963725054094, 974.7270764186039, 975.4781192062248, 975.8926518083006, 781.9413543984195, 974.2352253481018, 989.9455529945886, 994.2046362909715, 995.955182016811, 710.5026481462996, 712.8111050571603, 713.3508507258422, 713.668144312897, 713.8750718624271, 14121.15273083608, 14137.575872723732, 14186.290685465685, 14195.574132776033, 14198.0, 13691.657708557266, 14066.859331406657, 14083.155010699391, 14089.859101408958, 14324.068935519263, 10378.11785998191, 11144.554217831277, 11204.21570490066, 11224.607138750187, 11379.0, 3910.824012919397, 3969.7221194516396, 3972.960270397317, 3974.1654252606986, 3995.880123596297, 53798.0, 54458.18312725312, 55139.44860551423, 55178.17232741512, 55909.16136258, 11081.168912331608, 11190.776184476264, 11281.774364512663, 11320.320780753182, 11554.884451155382, 19649.508762281057, 19657.508562286057, 19657.803421965884, 19672.409827705193, 19675.90162049209, 7621.082975075216, 7736.0, 7764.767056988299, 8501.19238672325, 8521.36089793268, 4583.793729282191, 4666.60333871618, 4694.108119457293, 4737.24204127338, 4754.904901901942, 3226.0805670384298, 3243.9675603243663, 3257.03917344384, 3261.9836900815817, 3262.9836850815595, 577.5870252769206, 591.1841658511227, 629.9275583307887, 664.5414663881907, 678.6064082831946, 606.0212756398384, 638.4222278837659, 653.921529416473, 662.9270780214173, 663.8406782372195, 8080.636371363303, 8175.83648327042, 8660.090690477535, 8752.56237188138, 8825.91174088251, 504.17818955102945, 511.9820806271763, 524.3471877512445, 614.9108379284978, 653.0498125227782, 3911.002694312932, 3947.072437977073, 3967.504061992251, 3973.403989401555, 4033.495813023372, 61941.38058619356, 62506.37493625096, 62542.687286563276, 62601.686991565664, 62877.68561157165, 54748.0, 54933.725331373884, 55796.0, 56618.716906416026, 56656.71671641615, 49334.0, 49684.75157624261, 50091.49908500941, 50200.0, 51106.23340649819, 7981.321587664881, 8154.1030486647605, 8177.304929080857, 8267.659478773692, 8379.748607541784, 38615.2276954465, 38941.0, 39373.0, 39759.80120099381, 40244.79877600593, 48085.51914480951, 49110.77223069452, 49223.0, 50085.24872126848, 50244.49755502398, 10119.696409107739, 10222.693319200436, 10451.16390688728, 10612.0449159576, 11035.944820275847, 10903.752783467346, 10915.508802103766, 11006.889931100906, 11269.943650282024, 11383.772324553629, 9592.712218633453, 11610.94194529022, 11692.883071169179, 11715.589954351557, 12054.939725301669, 11197.160212983896, 11492.0, 11532.308061516336, 11671.649850504498, 11812.586559470377, 11340.94329528347, 11346.262492937933, 11350.772984540428, 11489.712757181138, 11655.30068195911, 9618.951905240428, 9787.21702263803, 9942.105210531086, 10027.348222365523, 10030.749231269278, 9701.951490242503, 9947.353422027545, 9949.950250248703, 10348.0, 10349.534270957674], "unit": "score", "name": "yui.html", "value": 6625.423163611813}], "name": "dromaeo_css", "value": 7093.804950427245}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 111.0, 110.0, 98.0, 108.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 151.0, 174.0, 127.0, 151.0, 148.0, 128.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 160.0, 164.0, 160.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 155.0, 74.0, 76.0, 73.0, 76.0, 157.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 148.0, 92.0, 93.0, 93.0, 137.0, 92.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 58.0, 63.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [119.0, 112.0, 116.0, 111.0, 117.0, 113.0, 108.0, 113.0, 109.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.8}, {"lowerIsBetter": true, "replicates": [144.0, 135.0, 144.0, 147.0, 157.0, 143.0, 138.0, 144.0, 134.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 71.0, 67.0, 69.0, 69.0, 65.0, 67.0, 64.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1493.5}]} 13:07:48 INFO - Return code: 0 13:07:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:07:48 INFO - # TBPL SUCCESS # 13:07:48 INFO - Running post-action listener: _resource_record_post_action 13:07:48 INFO - Running post-run listener: _resource_record_post_run 13:07:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 282624; Write bytes: 496918528; Read time: 60; Write time: 388200 13:07:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 214986752; Read time: 0; Write time: 190900 13:07:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 282624; Write bytes: 252293120; Read time: 60; Write time: 191960 13:07:49 INFO - Running post-run listener: _upload_blobber_files 13:07:49 INFO - Blob upload gear active. 13:07:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:07:49 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 13:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:07:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:50 INFO - (blobuploader) - INFO - Done attempting. 13:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:51 INFO - (blobuploader) - INFO - Done attempting. 13:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 13:07:51 INFO - Return code: 0 13:07:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:07:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31e2a96940201fad8a71099b81ca7c831b6c380671b71c4400028adcc6435db4ff035ca73b37f49f34246d3bd27e69295305120d13b49855483bbacc080c28e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e71df37407697d52a78f88d31f6b941781c6511ea6f4267ce53335daf23131c6884b3c5da334768450448a6c9f51107d89647a7754be9f9c66888ec97f5f852"} 13:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:07:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:07:51 INFO - Contents: 13:07:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31e2a96940201fad8a71099b81ca7c831b6c380671b71c4400028adcc6435db4ff035ca73b37f49f34246d3bd27e69295305120d13b49855483bbacc080c28e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e71df37407697d52a78f88d31f6b941781c6511ea6f4267ce53335daf23131c6884b3c5da334768450448a6c9f51107d89647a7754be9f9c66888ec97f5f852"} 13:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 13:07:51 INFO - Copying logs to upload dir... 13:07:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.175478 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-15 13:07:51.786974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 13:07:51.790753) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 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-Aurora/sha512/31e2a96940201fad8a71099b81ca7c831b6c380671b71c4400028adcc6435db4ff035ca73b37f49f34246d3bd27e69295305120d13b49855483bbacc080c28e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e71df37407697d52a78f88d31f6b941781c6511ea6f4267ce53335daf23131c6884b3c5da334768450448a6c9f51107d89647a7754be9f9c66888ec97f5f852"} build_url:https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/Fbd_-Uj2TPWnrKlLezMVKQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31e2a96940201fad8a71099b81ca7c831b6c380671b71c4400028adcc6435db4ff035ca73b37f49f34246d3bd27e69295305120d13b49855483bbacc080c28e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e71df37407697d52a78f88d31f6b941781c6511ea6f4267ce53335daf23131c6884b3c5da334768450448a6c9f51107d89647a7754be9f9c66888ec97f5f852"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 13:07:51.816315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 13:07:51.816658) ========= 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=eca2ab57546de7b41f256b19000001ef-1458071080.864658-803340765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 13:07:51.902156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 13:07:51.902490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 13:07:51.902803) ========= ========= Total master_lag: 0.24 =========