builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1457730119.01 results: success (0) buildid: 20160311103021 builduid: 694010dbee88443787ae428844ccbbbc revision: 946ed22cad04431c75ab5093989dfedf1bae5a3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.014543) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.015024) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.015426) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006276 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.036580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.036898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.050368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.050753) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.099893) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.100237) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.100624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.100920) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 13:01:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-03-11 13:01:59 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.203507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.203818) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.253685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:01:59.254042) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946ed22cad04431c75ab5093989dfedf1bae5a3e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 946ed22cad04431c75ab5093989dfedf1bae5a3e --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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 13:01:59,594 truncating revision to first 12 chars 2016-03-11 13:01:59,594 Setting DEBUG logging. 2016-03-11 13:01:59,595 attempt 1/10 2016-03-11 13:01:59,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946ed22cad04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 13:02:00,170 unpacking tar archive at: mozilla-central-946ed22cad04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835568 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:02:00.103099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 13:02:00.103452) ========= echo 946ed22cad04431c75ab5093989dfedf1bae5a3e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'946ed22cad04431c75ab5093989dfedf1bae5a3e'] 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 946ed22cad04431c75ab5093989dfedf1bae5a3e program finished with exit code 0 elapsedTime=0.004755 script_repo_revision: '946ed22cad04431c75ab5093989dfedf1bae5a3e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 13:02:00.154124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 13:02:00.154436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 13:02:00.164689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-11 13:02:00.165057) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:02:00 INFO - MultiFileLogger online at 20160311 13:02:00 in /builds/slave/test-pgo 13:02:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:02:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:02:00 INFO - {'append_to_log': False, 13:02:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:02:00 INFO - 'blob_upload_branch': 'Firefox', 13:02:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:02:00 INFO - 'branch': 'Firefox', 13:02:00 INFO - 'buildbot_json_path': 'buildprops.json', 13:02:00 INFO - 'config_files': ('talos/linux_config.py',), 13:02:00 INFO - 'default_actions': ('clobber', 13:02:00 INFO - 'read-buildbot-config', 13:02:00 INFO - 'download-and-extract', 13:02:00 INFO - 'populate-webroot', 13:02:00 INFO - 'create-virtualenv', 13:02:00 INFO - 'install', 13:02:00 INFO - 'run-tests'), 13:02:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:02:00 INFO - 'download_minidump_stackwalk': True, 13:02:00 INFO - 'download_symbols': 'ondemand', 13:02:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:02:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:02:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:02:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:02:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:02:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:02:00 INFO - 'installer_path': 'installer.exe', 13:02:00 INFO - 'log_level': 'info', 13:02:00 INFO - 'log_name': 'talos', 13:02:00 INFO - 'log_to_console': True, 13:02:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:02:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:02:00 INFO - 'opt_config_files': (), 13:02:00 INFO - 'pip_index': False, 13:02:00 INFO - 'sps_profile': False, 13:02:00 INFO - 'sps_profile_interval': 0, 13:02:00 INFO - 'suite': 'dromaeojs', 13:02:00 INFO - 'system_bits': '32', 13:02:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:00 INFO - 'title': 'talos-linux64-ix-016', 13:02:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:02:00 INFO - 'use_talos_json': True, 13:02:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:02:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:02:00 INFO - 'work_dir': 'build'} 13:02:00 INFO - ##### 13:02:00 INFO - ##### Running clobber step. 13:02:00 INFO - ##### 13:02:00 INFO - Running pre-action listener: _resource_record_pre_action 13:02:00 INFO - Running main action method: clobber 13:02:00 INFO - rmtree: /builds/slave/test-pgo/build 13:02:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:02:01 INFO - Running post-action listener: _resource_record_post_action 13:02:01 INFO - ##### 13:02:01 INFO - ##### Running read-buildbot-config step. 13:02:01 INFO - ##### 13:02:01 INFO - Running pre-action listener: _resource_record_pre_action 13:02:01 INFO - Running main action method: read_buildbot_config 13:02:01 INFO - Using buildbot properties: 13:02:01 INFO - { 13:02:01 INFO - "project": "", 13:02:01 INFO - "product": "firefox", 13:02:01 INFO - "script_repo_revision": "production", 13:02:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:02:01 INFO - "repository": "", 13:02:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:02:01 INFO - "buildid": "20160311103021", 13:02:01 INFO - "pgo_build": "True", 13:02:01 INFO - "basedir": "/builds/slave/test-pgo", 13:02:01 INFO - "buildnumber": 371, 13:02:01 INFO - "slavename": "talos-linux64-ix-016", 13:02:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:02:01 INFO - "platform": "ubuntu64_hw", 13:02:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:02:01 INFO - "branch": "mozilla-central", 13:02:01 INFO - "repo_path": "mozilla-central", 13:02:01 INFO - "revision": "946ed22cad04431c75ab5093989dfedf1bae5a3e", 13:02:01 INFO - "stage_platform": "linux64-pgo", 13:02:01 INFO - "builduid": "694010dbee88443787ae428844ccbbbc", 13:02:01 INFO - "slavebuilddir": "test" 13:02:01 INFO - } 13:02:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:02:01 INFO - Running post-action listener: _resource_record_post_action 13:02:01 INFO - ##### 13:02:01 INFO - ##### Running download-and-extract step. 13:02:01 INFO - ##### 13:02:01 INFO - Running pre-action listener: _resource_record_pre_action 13:02:01 INFO - Running main action method: download_and_extract 13:02:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:02:01 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')]} 13:02:01 INFO - https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:02:04 INFO - Downloaded 1361 bytes. 13:02:04 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:02:04 INFO - Using the following test package requirements: 13:02:04 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:04 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:02:04 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:02:04 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'jsshell-linux-x86_64.zip'], 13:02:04 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:02:04 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:04 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:02:04 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:02:04 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:02:04 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:02:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:02:04 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')]} 13:02:04 INFO - https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:06 INFO - Downloaded 23404082 bytes. 13:02:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:02:07 INFO - Return code: 0 13:02:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:02:07 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')]} 13:02:07 INFO - https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:10 INFO - Downloaded 23404082 bytes. 13:02:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:02:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:02:11 INFO - Return code: 0 13:02:11 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')]} 13:02:11 INFO - https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:02:12 INFO - Downloaded 10845263 bytes. 13:02:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:02:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:02:13 INFO - Return code: 0 13:02: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')]} 13:02:13 INFO - https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:02:16 INFO - Downloaded 56226685 bytes. 13:02:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:02:16 INFO - mkdir: /builds/slave/test-pgo/properties 13:02:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:02:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:02:16 INFO - Contents: 13:02:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:02:17 INFO - Running post-action listener: _resource_record_post_action 13:02:17 INFO - Running post-action listener: set_extra_try_arguments 13:02:17 INFO - ##### 13:02:17 INFO - ##### Running populate-webroot step. 13:02:17 INFO - ##### 13:02:17 INFO - Running pre-action listener: _resource_record_pre_action 13:02:17 INFO - Running main action method: populate_webroot 13:02:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:17 INFO - '--tppagecycles', 13:02:17 INFO - '7'], 13:02:17 INFO - 'tests': ['tsvgm']}}, 13:02:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:02:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:02:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:02:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'tests': ['damp', 'tps']}, 13:02:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['damp', 'tps']}, 13:02:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:02:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:17 INFO - 'other': {'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'other_l64': {'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'other_nol64': {'tests': ['a11yr', 13:02:17 INFO - 'ts_paint', 13:02:17 INFO - 'tpaint', 13:02:17 INFO - 'sessionrestore', 13:02:17 INFO - 'sessionrestore_no_auto_restore', 13:02:17 INFO - 'tabpaint']}, 13:02:17 INFO - 'svgr': {'tests': ['tsvgx', 13:02:17 INFO - 'tsvgr_opacity', 13:02:17 INFO - 'tart', 13:02:17 INFO - 'tscrollx', 13:02:17 INFO - 'cart']}, 13:02:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['tsvgx', 13:02:17 INFO - 'tsvgr_opacity', 13:02:17 INFO - 'tart', 13:02:17 INFO - 'tscrollx', 13:02:17 INFO - 'cart']}, 13:02:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'tests': ['tp5o']}, 13:02:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'talos_options': ['--e10s'], 13:02:17 INFO - 'tests': ['tp5o']}, 13:02:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'talos_options': ['--xperf_path', 13:02:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:17 INFO - 'tests': ['tp5n']}, 13:02:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:17 INFO - 'talos_options': ['--e10s', 13:02:17 INFO - '--xperf_path', 13:02:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:17 INFO - 'tests': ['tp5n']}}, 13:02:17 INFO - 'talos.zip': {'path': '', 13:02:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:17 INFO - Running post-action listener: _resource_record_post_action 13:02:17 INFO - ##### 13:02:17 INFO - ##### Running create-virtualenv step. 13:02:17 INFO - ##### 13:02:17 INFO - Running pre-action listener: _resource_record_pre_action 13:02:17 INFO - Running main action method: create_virtualenv 13:02:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:02:17 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 13:02:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:02:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:17 INFO - Using real prefix '/usr' 13:02:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:19 INFO - Installing pip.................done. 13:02:19 INFO - Return code: 0 13:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:19 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:19 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 13:02:19 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 13:02:19 INFO - Using env: {'DISPLAY': ':0', 13:02:19 INFO - 'HOME': '/home/cltbld', 13:02:19 INFO - 'LANG': 'en_US.UTF-8', 13:02:19 INFO - 'LANGUAGE': 'en_US:en', 13:02:19 INFO - 'LOGNAME': 'cltbld', 13:02:19 INFO - 'MAIL': '/var/mail/cltbld', 13:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:19 INFO - 'MOZ_NO_REMOTE': '1', 13:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:19 INFO - 'NO_EM_RESTART': '1', 13:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:19 INFO - 'SHELL': '/bin/bash', 13:02:19 INFO - 'SHLVL': '1', 13:02:19 INFO - 'TERM': 'linux', 13:02:19 INFO - 'TMOUT': '86400', 13:02:19 INFO - 'USER': 'cltbld', 13:02:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:19 INFO - '_': '/tools/buildbot/bin/python'} 13:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:20 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 13:02:20 INFO - Cleaning up... 13:02:20 INFO - Return code: 0 13:02:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:20 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:20 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 13:02:20 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 13:02:20 INFO - Using env: {'DISPLAY': ':0', 13:02:20 INFO - 'HOME': '/home/cltbld', 13:02:20 INFO - 'LANG': 'en_US.UTF-8', 13:02:20 INFO - 'LANGUAGE': 'en_US:en', 13:02:20 INFO - 'LOGNAME': 'cltbld', 13:02:20 INFO - 'MAIL': '/var/mail/cltbld', 13:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:20 INFO - 'MOZ_NO_REMOTE': '1', 13:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:20 INFO - 'NO_EM_RESTART': '1', 13:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:20 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:20 INFO - 'SHELL': '/bin/bash', 13:02:20 INFO - 'SHLVL': '1', 13:02:20 INFO - 'TERM': 'linux', 13:02:20 INFO - 'TMOUT': '86400', 13:02:20 INFO - 'USER': 'cltbld', 13:02:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:20 INFO - '_': '/tools/buildbot/bin/python'} 13:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:20 INFO - Downloading/unpacking psutil>=0.7.1 13:02:20 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 13:02:20 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 13:02:20 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 13:02:20 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 13:02:20 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 13:02:20 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 13:02:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:22 INFO - Installing collected packages: psutil 13:02:22 INFO - Running setup.py install for psutil 13:02:22 INFO - building 'psutil._psutil_linux' extension 13:02:22 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 13:02:22 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 13:02:22 INFO - building 'psutil._psutil_posix' extension 13:02:22 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 13:02:22 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 13:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:22 INFO - Successfully installed psutil 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:02:22 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')]} 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 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')]} 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:22 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 13:02:22 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 13:02:22 INFO - Using env: {'DISPLAY': ':0', 13:02:22 INFO - 'HOME': '/home/cltbld', 13:02:22 INFO - 'LANG': 'en_US.UTF-8', 13:02:22 INFO - 'LANGUAGE': 'en_US:en', 13:02:22 INFO - 'LOGNAME': 'cltbld', 13:02:22 INFO - 'MAIL': '/var/mail/cltbld', 13:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:22 INFO - 'MOZ_NO_REMOTE': '1', 13:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:22 INFO - 'NO_EM_RESTART': '1', 13:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:22 INFO - 'SHELL': '/bin/bash', 13:02:22 INFO - 'SHLVL': '1', 13:02:22 INFO - 'TERM': 'linux', 13:02:22 INFO - 'TMOUT': '86400', 13:02:22 INFO - 'USER': 'cltbld', 13:02:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:22 INFO - '_': '/tools/buildbot/bin/python'} 13:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:02:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:02:25 INFO - Installing collected packages: mozsystemmonitor 13:02:25 INFO - Running setup.py install for mozsystemmonitor 13:02:25 INFO - Successfully installed mozsystemmonitor 13:02:25 INFO - Cleaning up... 13:02:25 INFO - Return code: 0 13:02:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:25 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:25 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 13:02:25 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 13:02:25 INFO - Using env: {'DISPLAY': ':0', 13:02:25 INFO - 'HOME': '/home/cltbld', 13:02:25 INFO - 'LANG': 'en_US.UTF-8', 13:02:25 INFO - 'LANGUAGE': 'en_US:en', 13:02:25 INFO - 'LOGNAME': 'cltbld', 13:02:25 INFO - 'MAIL': '/var/mail/cltbld', 13:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:25 INFO - 'MOZ_NO_REMOTE': '1', 13:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:25 INFO - 'NO_EM_RESTART': '1', 13:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:25 INFO - 'SHELL': '/bin/bash', 13:02:25 INFO - 'SHLVL': '1', 13:02:25 INFO - 'TERM': 'linux', 13:02:25 INFO - 'TMOUT': '86400', 13:02:25 INFO - 'USER': 'cltbld', 13:02:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:25 INFO - '_': '/tools/buildbot/bin/python'} 13:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:02:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 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 13:02:27 INFO - Downloading docopt-0.6.1.tar.gz 13:02:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:27 INFO - Running setup.py install for blobuploader 13:02:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:02:28 INFO - Running setup.py install for requests 13:02:28 INFO - Running setup.py install for docopt 13:02:28 INFO - Successfully installed blobuploader requests docopt 13:02:28 INFO - Cleaning up... 13:02:28 INFO - Return code: 0 13:02:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:28 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:28 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 13:02:28 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 13:02:28 INFO - Using env: {'DISPLAY': ':0', 13:02:28 INFO - 'HOME': '/home/cltbld', 13:02:28 INFO - 'LANG': 'en_US.UTF-8', 13:02:28 INFO - 'LANGUAGE': 'en_US:en', 13:02:28 INFO - 'LOGNAME': 'cltbld', 13:02:28 INFO - 'MAIL': '/var/mail/cltbld', 13:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:28 INFO - 'MOZ_NO_REMOTE': '1', 13:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:28 INFO - 'NO_EM_RESTART': '1', 13:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:28 INFO - 'SHELL': '/bin/bash', 13:02:28 INFO - 'SHLVL': '1', 13:02:28 INFO - 'TERM': 'linux', 13:02:28 INFO - 'TMOUT': '86400', 13:02:28 INFO - 'USER': 'cltbld', 13:02:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:28 INFO - '_': '/tools/buildbot/bin/python'} 13:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:28 INFO - Running setup.py (path:/tmp/pip-i_TGkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:28 INFO - Running setup.py (path:/tmp/pip-4yoASd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:28 INFO - Running setup.py (path:/tmp/pip-YMYOQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:28 INFO - Running setup.py (path:/tmp/pip-LaAZfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:29 INFO - Running setup.py (path:/tmp/pip-_Y8jgD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:29 INFO - Running setup.py (path:/tmp/pip-APffHB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:29 INFO - Running setup.py (path:/tmp/pip-wpK9GV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:29 INFO - Running setup.py (path:/tmp/pip-P4OWAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:29 INFO - Running setup.py (path:/tmp/pip-BlvvuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:29 INFO - Running setup.py (path:/tmp/pip-yCFbsV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:29 INFO - Running setup.py (path:/tmp/pip-GcTKXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:29 INFO - Running setup.py (path:/tmp/pip-IINolR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:29 INFO - Running setup.py (path:/tmp/pip-mFoMB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:29 INFO - Running setup.py (path:/tmp/pip-2ucQFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:29 INFO - Running setup.py (path:/tmp/pip-3bDLKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:29 INFO - Running setup.py (path:/tmp/pip-dAl3wO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:29 INFO - Running setup.py (path:/tmp/pip-DgjNgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:29 INFO - Running setup.py install for manifestparser 13:02:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for mozcrash 13:02:30 INFO - Running setup.py install for mozdebug 13:02:30 INFO - Running setup.py install for mozdevice 13:02:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for mozfile 13:02:30 INFO - Running setup.py install for mozhttpd 13:02:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for mozinfo 13:02:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for mozInstall 13:02:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for mozleak 13:02:30 INFO - Running setup.py install for mozlog 13:02:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:02:30 INFO - Running setup.py install for moznetwork 13:02:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Running setup.py install for mozprocess 13:02:31 INFO - Running setup.py install for mozprofile 13:02:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Running setup.py install for mozrunner 13:02:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Running setup.py install for mozscreenshot 13:02:31 INFO - Running setup.py install for moztest 13:02:31 INFO - Running setup.py install for mozversion 13:02:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:02:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:31 INFO - Cleaning up... 13:02:31 INFO - Return code: 0 13:02:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:31 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:31 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 13:02:31 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 13:02:31 INFO - Using env: {'DISPLAY': ':0', 13:02:31 INFO - 'HOME': '/home/cltbld', 13:02:31 INFO - 'LANG': 'en_US.UTF-8', 13:02:31 INFO - 'LANGUAGE': 'en_US:en', 13:02:31 INFO - 'LOGNAME': 'cltbld', 13:02:31 INFO - 'MAIL': '/var/mail/cltbld', 13:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:31 INFO - 'MOZ_NO_REMOTE': '1', 13:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:31 INFO - 'NO_EM_RESTART': '1', 13:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:31 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:31 INFO - 'SHELL': '/bin/bash', 13:02:31 INFO - 'SHLVL': '1', 13:02:31 INFO - 'TERM': 'linux', 13:02:31 INFO - 'TMOUT': '86400', 13:02:31 INFO - 'USER': 'cltbld', 13:02:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:31 INFO - '_': '/tools/buildbot/bin/python'} 13:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:31 INFO - Running setup.py (path:/tmp/pip-HZeOUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:32 INFO - Running setup.py (path:/tmp/pip-pkyrf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:32 INFO - Running setup.py (path:/tmp/pip-7IIbSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:32 INFO - Running setup.py (path:/tmp/pip-VhbGKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:32 INFO - Running setup.py (path:/tmp/pip-oYTk52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:32 INFO - Running setup.py (path:/tmp/pip-IdCYUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:32 INFO - Running setup.py (path:/tmp/pip-XfKELU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:32 INFO - Running setup.py (path:/tmp/pip-pDJ6bB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:32 INFO - Running setup.py (path:/tmp/pip-1IejaR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:32 INFO - Running setup.py (path:/tmp/pip-8HAiyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:32 INFO - Running setup.py (path:/tmp/pip-tLTSMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:32 INFO - Running setup.py (path:/tmp/pip-b2vC14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:32 INFO - Running setup.py (path:/tmp/pip-3v1Wb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:32 INFO - Running setup.py (path:/tmp/pip-qlHUzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:32 INFO - Running setup.py (path:/tmp/pip-BbwANS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:33 INFO - Running setup.py (path:/tmp/pip-yKtW14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:33 INFO - Running setup.py (path:/tmp/pip-Nf6iFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:34 INFO - Downloading blessings-1.6.tar.gz 13:02:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:35 INFO - Installing collected packages: blessings 13:02:35 INFO - Running setup.py install for blessings 13:02:35 INFO - Successfully installed blessings 13:02:35 INFO - Cleaning up... 13:02:35 INFO - Return code: 0 13:02:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:02:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:35 INFO - Reading from file tmpfile_stdout 13:02:35 INFO - Current package versions: 13:02:35 INFO - argparse == 1.2.1 13:02:35 INFO - blessings == 1.6 13:02:35 INFO - blobuploader == 1.2.4 13:02:35 INFO - docopt == 0.6.1 13:02:35 INFO - manifestparser == 1.1 13:02:35 INFO - mozInstall == 1.12 13:02:35 INFO - mozcrash == 0.17 13:02:35 INFO - mozdebug == 0.1 13:02:35 INFO - mozdevice == 0.48 13:02:35 INFO - mozfile == 1.2 13:02:35 INFO - mozhttpd == 0.7 13:02:35 INFO - mozinfo == 0.9 13:02:35 INFO - mozleak == 0.1 13:02:35 INFO - mozlog == 3.1 13:02:35 INFO - moznetwork == 0.27 13:02:35 INFO - mozprocess == 0.22 13:02:35 INFO - mozprofile == 0.28 13:02:35 INFO - mozrunner == 6.11 13:02:35 INFO - mozscreenshot == 0.1 13:02:35 INFO - mozsystemmonitor == 0.0 13:02:35 INFO - moztest == 0.7 13:02:35 INFO - mozversion == 1.4 13:02:35 INFO - psutil == 3.1.1 13:02:35 INFO - requests == 1.2.3 13:02:35 INFO - wsgiref == 0.1.2 13:02:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 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 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:35 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 13:02:35 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 13:02:35 INFO - Using env: {'DISPLAY': ':0', 13:02:35 INFO - 'HOME': '/home/cltbld', 13:02:35 INFO - 'LANG': 'en_US.UTF-8', 13:02:35 INFO - 'LANGUAGE': 'en_US:en', 13:02:35 INFO - 'LOGNAME': 'cltbld', 13:02:35 INFO - 'MAIL': '/var/mail/cltbld', 13:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:35 INFO - 'MOZ_NO_REMOTE': '1', 13:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:35 INFO - 'NO_EM_RESTART': '1', 13:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:35 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:35 INFO - 'SHELL': '/bin/bash', 13:02:35 INFO - 'SHLVL': '1', 13:02:35 INFO - 'TERM': 'linux', 13:02:35 INFO - 'TMOUT': '86400', 13:02:35 INFO - 'USER': 'cltbld', 13:02:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:35 INFO - '_': '/tools/buildbot/bin/python'} 13:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 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)) 13:02:35 INFO - Cleaning up... 13:02:35 INFO - Return code: 0 13:02:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:02:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:02:35 INFO - Using env: {'DISPLAY': ':0', 13:02:35 INFO - 'HOME': '/home/cltbld', 13:02:35 INFO - 'LANG': 'en_US.UTF-8', 13:02:35 INFO - 'LANGUAGE': 'en_US:en', 13:02:35 INFO - 'LOGNAME': 'cltbld', 13:02:35 INFO - 'MAIL': '/var/mail/cltbld', 13:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:35 INFO - 'MOZ_NO_REMOTE': '1', 13:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:35 INFO - 'NO_EM_RESTART': '1', 13:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:35 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:35 INFO - 'SHELL': '/bin/bash', 13:02:35 INFO - 'SHLVL': '1', 13:02:35 INFO - 'TERM': 'linux', 13:02:35 INFO - 'TMOUT': '86400', 13:02:35 INFO - 'USER': 'cltbld', 13:02:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:35 INFO - '_': '/tools/buildbot/bin/python'} 13:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:35 INFO - Downloading/unpacking jsonschema 13:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:37 INFO - Downloading/unpacking functools32 (from jsonschema) 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:37 INFO - warning: no files found matching '*.txt' 13:02:37 INFO - no previously-included directories found matching 'build' 13:02:37 INFO - no previously-included directories found matching 'dist' 13:02:37 INFO - no previously-included directories found matching '.git*' 13:02:37 INFO - Installing collected packages: jsonschema, functools32 13:02:38 INFO - Running setup.py install for functools32 13:02:38 INFO - warning: no files found matching '*.txt' 13:02:38 INFO - no previously-included directories found matching 'build' 13:02:38 INFO - no previously-included directories found matching 'dist' 13:02:38 INFO - no previously-included directories found matching '.git*' 13:02:38 INFO - Successfully installed jsonschema functools32 13:02:38 INFO - Cleaning up... 13:02:38 INFO - Return code: 0 13:02:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:02: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')]} 13:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74ad2aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, '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': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', '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 13:02: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', 'flake8'] in /builds/slave/test-pgo/build 13:02: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 flake8 13:02:38 INFO - Using env: {'DISPLAY': ':0', 13:02:38 INFO - 'HOME': '/home/cltbld', 13:02:38 INFO - 'LANG': 'en_US.UTF-8', 13:02:38 INFO - 'LANGUAGE': 'en_US:en', 13:02:38 INFO - 'LOGNAME': 'cltbld', 13:02:38 INFO - 'MAIL': '/var/mail/cltbld', 13:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:38 INFO - 'MOZ_NO_REMOTE': '1', 13:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:38 INFO - 'NO_EM_RESTART': '1', 13:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:38 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:38 INFO - 'SHELL': '/bin/bash', 13:02:38 INFO - 'SHLVL': '1', 13:02:38 INFO - 'TERM': 'linux', 13:02:38 INFO - 'TMOUT': '86400', 13:02:38 INFO - 'USER': 'cltbld', 13:02:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:38 INFO - '_': '/tools/buildbot/bin/python'} 13:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:38 INFO - Downloading/unpacking flake8 13:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:02:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:02:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:02:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:40 INFO - no previously-included directories found matching 'docs/_build' 13:02:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:02:40 INFO - Running setup.py install for pep8 13:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:02:41 INFO - no previously-included directories found matching 'docs/_build' 13:02:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:02:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:02:41 INFO - Cleaning up... 13:02:41 INFO - Return code: 0 13:02:41 INFO - Running post-action listener: _resource_record_post_action 13:02:41 INFO - Running post-action listener: _start_resource_monitoring 13:02:41 INFO - Starting resource monitoring. 13:02:41 INFO - ##### 13:02:41 INFO - ##### Running install step. 13:02:41 INFO - ##### 13:02:41 INFO - Running pre-action listener: _resource_record_pre_action 13:02:41 INFO - Running main action method: install 13:02:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:02:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:02:41 INFO - Reading from file tmpfile_stdout 13:02:41 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:02:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:02:41 INFO - Reading from file tmpfile_stdout 13:02:41 INFO - Output received: 13:02:41 INFO - Usage: mozinstall [options] installer 13:02:41 INFO - Options: 13:02:41 INFO - -h, --help show this help message and exit 13:02:41 INFO - -d DEST, --destination=DEST 13:02:41 INFO - Directory to install application into. [default: 13:02:41 INFO - "/builds/slave/test-pgo"] 13:02:41 INFO - --app=APP Application being installed. [default: firefox] 13:02:41 INFO - mkdir: /builds/slave/test-pgo/build/application 13:02:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:02:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:02:57 INFO - Reading from file tmpfile_stdout 13:02:57 INFO - Output received: 13:02:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:02:57 INFO - Running post-action listener: _resource_record_post_action 13:02:57 INFO - ##### 13:02:57 INFO - ##### Running run-tests step. 13:02:57 INFO - ##### 13:02:57 INFO - Running pre-action listener: _resource_record_pre_action 13:02:57 INFO - Running main action method: run_tests 13:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:02:57 INFO - Python 2.7.3 13:02:57 INFO - Return code: 0 13:02:57 INFO - grabbing minidump binary from tooltool 13:02: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')]} 13:02:57 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 0x1ef9920>, '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 0x1efa820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efacb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:02:57 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 13:02:57 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 13:02:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:02:57 INFO - Return code: 0 13:02:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:02:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:02:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:02:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:02:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:02:58 INFO - Return code: 0 13:02:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 13:02:58 INFO - Using env: {'DISPLAY': ':0', 13:02:58 INFO - 'HOME': '/home/cltbld', 13:02:58 INFO - 'LANG': 'en_US.UTF-8', 13:02:58 INFO - 'LANGUAGE': 'en_US:en', 13:02:58 INFO - 'LOGNAME': 'cltbld', 13:02:58 INFO - 'MAIL': '/var/mail/cltbld', 13:02:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:58 INFO - 'MOZ_NO_REMOTE': '1', 13:02:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:58 INFO - 'NO_EM_RESTART': '1', 13:02:58 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:02:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:02:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:02:58 INFO - 'SHELL': '/bin/bash', 13:02:58 INFO - 'SHLVL': '1', 13:02:58 INFO - 'TERM': 'linux', 13:02:58 INFO - 'TMOUT': '86400', 13:02:58 INFO - 'USER': 'cltbld', 13:02:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457729640.744866-585651980', 13:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:58 INFO - '_': '/tools/buildbot/bin/python'} 13:02:58 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:02:58 INFO - mozversion application_buildid: 20160311103021 13:02:58 INFO - mozversion application_changeset: 946ed22cad04431c75ab5093989dfedf1bae5a3e 13:02:58 INFO - mozversion application_display_name: Nightly 13:02:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:02:58 INFO - mozversion application_name: Firefox 13:02:58 INFO - mozversion application_remotingname: firefox 13:02:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:02:58 INFO - mozversion application_vendor: Mozilla 13:02:58 INFO - mozversion application_version: 48.0a1 13:02:58 INFO - mozversion platform_buildid: 20160311103021 13:02:58 INFO - mozversion platform_changeset: 946ed22cad04431c75ab5093989dfedf1bae5a3e 13:02:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:02:58 INFO - mozversion platform_version: 48.0a1 13:02:58 INFO - using testdate: 1457730178 13:02:58 INFO - actual date: 1457730178 13:02:58 INFO - starting webserver on 'localhost:60833' 13:02:58 INFO - SUITE-START | Running 2 tests 13:02:58 INFO - TEST-START | dromaeo_css 13:02:58 INFO - operating with platform_type : linux_ 13:02:58 INFO - Initialising browser for dromaeo_css test... 13:02:58 INFO - TEST-INFO | started process 17555 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwHJlzh/profile http://localhost:60833/getInfo.html) 13:03:03 INFO - PROCESS | 17555 | __metrics Screen width/height:1600/1200 13:03:03 INFO - PROCESS | 17555 | colorDepth:24 13:03:03 INFO - PROCESS | 17555 | Browser inner width/height: 1024/697 13:03:03 INFO - PROCESS | 17555 | __metrics 13:03:04 ERROR - PROCESS | 17555 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:03:05 INFO - TEST-INFO | 17555: exit 0 13:03:05 INFO - Browser initialized. 13:03:05 INFO - Running cycle 1/1 for dromaeo_css test... 13:03:05 INFO - TEST-INFO | started process 17648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwHJlzh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:16 INFO - PROCESS | 17648 | RSS: Main: 155062272 13:03:16 INFO - PROCESS | 17648 | 13:04:08 INFO - PROCESS | 17648 | 1457730248347 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] 13:06:16 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60833/tests/dromaeo/cssquery-ext.html) 13:06:17 INFO - PROCESS | 17648 | RSS: Main: 258224128 13:06:17 INFO - PROCESS | 17648 | 13:09:19 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-ext.html (next: http://localhost:60833/tests/dromaeo/cssquery-jquery.html) 13:09:20 INFO - PROCESS | 17648 | RSS: Main: 228016128 13:09:20 INFO - PROCESS | 17648 | 13:12:21 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60833/tests/dromaeo/cssquery-mootools.html) 13:12:22 INFO - PROCESS | 17648 | RSS: Main: 233185280 13:12:22 INFO - PROCESS | 17648 | 13:15:24 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60833/tests/dromaeo/cssquery-prototype.html) 13:15:24 INFO - PROCESS | 17648 | RSS: Main: 218980352 13:15:24 INFO - PROCESS | 17648 | 13:18:27 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60833/tests/dromaeo/cssquery-yui.html) 13:18:28 INFO - PROCESS | 17648 | RSS: Main: 216207360 13:18:28 INFO - PROCESS | 17648 | 13:21:30 INFO - PROCESS | 17648 | Cycle 1(1): loaded http://localhost:60833/tests/dromaeo/cssquery-yui.html (next: http://localhost:60833/tests/dromaeo/cssquery-dojo.html) 13:21:31 INFO - PROCESS | 17648 | RSS: Main: 313495552 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | __start_tp_report 13:21:31 INFO - PROCESS | 17648 | _x_x_mozilla_page_load 13:21:31 INFO - PROCESS | 17648 | _x_x_mozilla_page_load_details 13:21:31 INFO - PROCESS | 17648 | |i|pagename|runs| 13:21:31 INFO - PROCESS | 17648 | |0;dojo.html;3133.514305282681;3166.113488223298;3196.5524826524293;3204.3591281743643;3225.354929014197;4910.361652985116;5001;5048.545630893219;5073.2643766653855;5092.898142037157;5049.772760225789;5077.6953382797055;5082.847514574569;5086.313347698059;5113.846584602468;4544.272916333395;4582.587567118959;4587.587117159455;4715.269133284346;4792.7124372537755;4522;4581.541845815425;4701.576858082772;4714.90570188596;4782.210935195689;4559.794809233559;4589.403377560929;4610.170169369512;4626.606738427204;4628.537146285362;4569.977150114261;4584.106099310636;4585.449746030497;4593.885152871171;4648.1168577970075;4572.039871626962;4578.954210457886;4592.747398893093;4628.629709623222;4691.741954192518;4929.482404347564;4930.433000204951;4945;4946.480619534969;4980.178270585386;5413.404525502192;5416.322959630046;5423.105187644034;5425.131978883399;5478.479544443271;5398.73006349681;5449.891002179974;5466.34403871538;5525.11598144295;5525.502704756591;5024.748762561857;5031.345925029759;5035.395752509722;5038.823641172541;5039.21892106724;5454.781808727606;5485.50630443262;5486.6982315973;5497.5601951843755;5529.861753456195;5305.681659100389;5330.92003619946;5337.172738225581;5363.570914326844;5396.946030539723;5364.463553644604;5364.463553644604;5367.355917289872;5373.596980226499;5374.623776335619;5245.10833158364;5337.733113344318;5339.199120132012;5344.412114667383;5394.78420863169;5407.756650950717;5429.375621803464;5446.809361672402;5451.945480545223;5491.121420572689;4165.729227600196;4176.582341765799;4176.853810116631;4177.185448837447;4210.431591735077;3713.405855063177;3730.198007428416;3782.016675664292;3817.828197731109;3833.4824798651825;5145.228215767665;5156.1750119980625;5165.276861239429;5199.4020687621405;5211.322528071327;5435.83692489226;5454.290942177571;5460.918086228709;5464.9453505465235;5500.1749737538885;5017.749112544431;5082.847514574569;5122.820701275437;5158.535731784157;5174.534291913746;4674.95325046752;4679.485256621769;4680.227762419163;4685.437747470257;4722.574968252874;5704.372519022904;5716.08542633185;5717.313922329347;5722.4277572242445;5752.827415177551;5321.494458026481;5336.573074154136;5405.054115529845;5422.864428389322;5436.972815136057;5638.85902852432;5662.094064949588;5663;5664.26364572603;5712;5352.437994010573;5359.490848369399;5363;5377.327834020747;5414.810481633124;5318;5442.292501974718;5448.182772584144;5523.834284971457;5526.253955715927;5205.219217117463;5217.895642087061;5222.738863056908;5224.52979231871;5224.582033437392;5214.791408343775;5221.039237322713;5223.033738758342;5229.895402091861;5252.317198764136;5115.2071428928575;5171.844844654666;5190.740462976912;5236.057509648148;5249.973750131225;5328.960852633699;5360.43715409892;5360.490753378423;5367.329083864517;5373.7850485980125;5158.767855446589;5230.8169214077325;5256.605754568346;5256.6320357574605;5299.417064122867 13:21:31 INFO - PROCESS | 17648 | |1;ext.html;489.6180978836509;521.0568870344674;538.6687187379763;558.8574913397083;601.8074216250799;28128.156155315348;28475.572866406994;28595.714042859567;28683.569746453766;28694.713052869516;36759;36936.815315923384;36970.26059478809;36996.44505332422;37024;8457.492550446992;8682.392232543725;8689.391742578022;8692.47845129291;8694.17405346491;7526.322630963212;8439.70461033864;8635.784105397352;10247.897521024768;10517.368957862553;10234.53944572496;10323.896761032369;10335.689929302096;10356.896431035706;10365.637202697908;10061.547230374614;10133.797324053552;10147.086762191439;10168.745781355452;10169;9877.703668889944;10076.395416275047;10082.69751907444;10085.243606729451;10085.49572521371;36286.81856590726;36669.266614667824;36828.44757328642;40586.18827623461;40636.187276254605;3570.8571657133684;3638.7998660073686;3654.214343916044;3796.4814074370474;4007.3988901664984;30452.84773576118;30512.04265946413;30775.538366924513;30844.22889427782;31856.681433185604;3210.6628803975714;3219.404410184123;3241.1897025743565;3296.5220043093855;3351.162209447638;290757;291439;292363.5381823098;292462;293336;42065.369019464735;42590.78704606457;58803.70598147067;59400.40599593949;59457.70271148616;40053.79973100174;40096;40239;40252.79873600672;40262.597374025885;13154.802677959839;13272.535461258809;13276.137051091648;13278.20330780137;13286.402111904987;9380.765480862896;10201.795964080677;10202.489875506195;10247.59009639621;10285.7428564285;13947.930260348634;14137.575872723835;14148.64628384278;14219.075760075562;14224.21766802815;5456.290682211287;5545.694986775766;5641.52047075995;5670.688112153871;5676.801311954062;850.7107583421666;890.2966656341417;935.5462600638684;1023.4268809466722;1028.228828378716;26696.733032669814;26874.5968810468;27237.727622723916;28052.29869253285;29073.127806165427;996.7059717383389;1004.6634377483625;1006.8892421833592;1011.1354791653031;1055.3456856748865;14637.853621463863;15167.208197950513;15199.184255335851;15244.542663720105;15292.464763733216;319917;322122;324735;325191;325485;52052;52628.736856315474;52673.73663131736;52745.2088218677;52749;1285.958373717292;1308.9214647121203;1322.6561094115407;1336.492132989477;1405.1779708870222;25452.363690907136;28651.28371790722;28697.28256793597;29177.562336565392;29200.26999325034;39236.80381598188;39850.20299593934;39924.401133982436;39978.60021399749;40027.79986100051;183062;183744;183762;183779;184285;27305;31704.36591268208;32027;32065;32314.515282270313;37107;37548.2490350186;37775.62224377721;38115;38227;33587;34178.65821341755;34430.311393772485;34714.30571388609;36013.27973440569;34039.31921361609;34157.48763768496;34227;34314;34666.65333346634;34398.65601343955;34870;34945;35359.46960795642;35530.28939421249;29446.705532944397;30851.69148308488;30960.53559196659;30978.845105774326;31298.374032519678;24108.156214532406;24226.394340141636;24244.272671819872;24423.14518991827;24666.630000550365 13:21:31 INFO - PROCESS | 17648 | |2;jquery.html;351.33597500723636;360.7961501751511;365.3879751416377;366.5912507554077;371.5263039624477;16504.174791260433;16533.917330413347;17196.82803171968;17199.398021069264;17201.88187767796;15430.768538471904;15723;16001.27994240259;16012.83987160128;16016.919915400407;5423.159410291411;5467.234587157791;5475.260839786618;5550.111982082867;5621.80323688671;5485.588580856432;5534.03154447972;5548.500634942854;5554.19464177696;5574.247476590669;5356.9732151339185;5439.864003399907;5490.121580547113;5491.917621235664;5554.2779438672915;5427.674339539621;5445.047116754592;5450.727463626803;5464.3442786865635;5467.917981230285;4849;4890.217565189552;4899.363082799249;4904.926426103611;4912.066707325596;19901.800981990284;20204.19183232669;20467.07898144587;20489.28287509945;20602.58794824095;2309.2494939144676;2590.9870450647813;2724.101046654599;2915.8833646654107;2978.8659510322086;12954.222746635138;13067.607971760863;13249.86750132496;13461.932690336584;13509.59471215865;1854.4992851929903;1854.6105317883262;1922.9903850480798;1932.5072106612865;2002.2591641092888;59365.40634593642;59540.10689839656;60130;60753.392466075216;61015.38984610186;9942.751431214278;10062.19502439803;10207.489625518694;10330.121939635064;10457.790844183226;13564.728705425836;13635.795463068062;13675.111117777511;13676.452941882413;13708.862911370958;7507.253503811163;7561.2060733623275;7621.50460220095;7697.730579429693;7739.955106060723;6987.056747339146;7087.82280442993;7095.751648692374;7349.338559529561;7593.278638529331;6117.816465506042;6159.784407545714;6163.075538669146;6229.159063526366;6284.183056202756;1771.0967406622458;1800.5048611631905;1806.3677712800416;1810.9456716298532;1848.5378655336167;920.4799288402031;938.3666025432806;972.6838777397375;979.118793086228;1008.8537162111453;16734;16978.57553561146;16979.575510612085;17095.99064383597;17141.657166856843;914.0996118822954;924.67174153176;926.6478738079621;929.818685356349;941.9058094190664;9703.466309353053;9936.602535898628;9948.303618746762;10028.899711002796;10070.395776253448;411262;415259;419674;431186;431470;46082;56338.71830640903;61212.69393653092;61986.38013619806;65396.34603653998;1025.9127974122134;1030.4023666273692;1036.8133735927606;1069.13934282903;1070.0583486531957;15033.624159396102;15184.240787960778;15355.309011094305;15543.222838858239;15790.289436975594;31308.373832522768;31963;32144.678553215104;32446.188845279055;32574;43316;46031.309530356404;46154;46321.84195395142;47621.28568071412;7474.14047384536;7590.7722768317035;7700.8844867325915;7703.152653208031;7739.92260077392;9748.951255243679;11530.481128349076;11530.94234528822;11553.595624153451;11750.764984700429;10163.491825408848;10209.38743675382;10280.177585793268;10299.3820370778;10324.638637647646;9895.901040989498;10001.949990250294;10091.495425228855;10164.288499804943;10220.335678180894;10239.283250172417;10333.276670632984;10418.843717344398;10463.476826158509;10500.054995050483;7320.890186647098;7362.7054917804835;7424.071991001125;7496;7496.9250307498405;9127.497987610745;10111.696649100539;10119;10196.643117490852;10290.12533934624 13:21:31 INFO - PROCESS | 17648 | |3;mootools.html;1359.4901911783081;1451.2453524167433;1472.3006571878357;1632.2165360626898;1788.5171003828966;7149.606771627558;7313.488055836094;7319.560826350423;7325.377342925858;7329.633518324089;7285.635718214095;7443.627818609075;7448.404127669787;7452.254774522558;7473.775786726394;1956.1979588368772;2001.7998200180011;2207.635740102889;2268.0587556164173;2309.2956648222284;2267.489814791675;2270.103309192868;2277.3054218463362;2277.851939623919;2278.3734473019886;2187.84685072045;2201.2625770366944;2244.0911430870524;2244.9551008979893;2245.6743772153027;2238.2278114050628;2243.4952135769486;2248.2243625949022;2251.549690061986;2295.781900719429;2245.4610893385634;2265.0713207584813;2282.2582660635194;2283.7145356830397;2286.5998450271136;7442.962785186093;7483.588402637853;7494.550326980344;7499;7511.849763004764;4667.6732628716;4775.928361074587;4787.40157480315;4788.425388953313;4790.520947905216;2942.3820997590533;3093.4586447371844;3113.4551453495546;3158.0683698309053;3176.332970076264;937.7421209167534;945.8628498867625;1019.8470229465565;1024.7335692719946;1053.1627356251797;10575.947120264427;10642.680719578348;10650.520726567323;10653.9467302663;10687.412192329497;3975.940360894589;4157.854475093357;4217.557156498585;4237.936430953539;4252.340887162495;8384.077751447336;8434.28308593764;8441.788955276168;8473.661053557911;8477.533735644476;4612.077584483117;4635.791389387486;4646.93120582268;4650.255959046536;4654.534546545318;3863;4260.914781704349;4304.935425968613;4333.739975601474;4345.304751239786;3423.5549378580627;3425.760196786201;3494.3186078714916;3514.9824250878582;3535.7171426285836;995.069609914732;1005.2862467647906;1013.614826365991;1017.3336464615688;1044.7805960748176;1322.444573279225;1335.599320203935;1341.235495767403;1356.1727346318737;1383.9377228024764;7037.929620703728;7140.7857764267155;7166.856662866713;7253.057102576631;7384;1054.7099547624312;1076.1821016027875;1130.0846314485293;1137.8919002694731;1141.366541569437;5750.827475175752;5768.538516918637;5811.79658711943;5812.564057695689;5818.883622327529;8725;8854.893138357706;9079.546022698838;9179.724608261762;9220;9156.725298241063;9174.449533028039;9274.118958698913;9310.953445232866;9365.625374984924;6958.06066181059;7128.358447739624;7166.355028047501;7167.928320716726;7217.783466496118;7165.176004759519;7189.388901943394;7214.74748383804;7216.927830721836;7247.673854676446;7919.604019799102;8126;8213.630386632736;8261.83476330482;8282.4202305838;8137.79655508617;8287;8419.663213471393;8436.789080273042;8439.367047471587;6469.191351081115;6567.113439685581;6877.140357455318;6941.583504989515;6968.756093536702;7407.8148046299275;7429.888551671837;7462.626868656654;7463.477556570988;7479.925200748141;6653.334666533308;6823.874060779915;6861.794146175623;7034.753783617549;7037.824054398477;6744.494162937701;6758.3917447428;6811.421029212573;6833.4191593715095;6891.173059232924;6997.1253593300835;7056.6118863463;7074.787756367317;7103.9289607103265;7112.288771122846;6501.512386570931;6502.967485162544;6516.478681705357;6547.934520654923;6552.63960482178;6523.412892839668;6533.477321814148;6584.407403333723;6596.670166491752;6605.834854128685 13:21:31 INFO - PROCESS | 17648 | |4;prototype.html;348.7645839058638;351.3219486391264;351.9348920449717;352.1794219468638;355.17244819570396;5799.855003624912;5816.476517113459;5852.970735146329;5881.382454842244;5910.290765108193;5804.7968321108665;5814.912776308348;5826.533877289818;5832.154337621042;5834.737436815343;4324.805383757731;4422.11557688462;4547.772611369418;4587.977060114711;4595.241785105453;4538.410006699124;4560.8859778505475;4570.680052396334;4577.313402989545;4583.679142460029;4363.083752411997;4532.365468834366;4534.9319760203625;4534.9773251133865;4539.432570928634;4408.20652282589;4505.909881802379;4526.388937493429;4533.5013148553635;4558.38461807655;3972.940405893914;4004.659603933669;4015.4779878615886;4017.517897852247;4031.21391328691;5572.3870374258795;5583.3858275589655;5585.636933599303;5595.328560572717;5604.271444712162;5275.155975043975;5275.841724748264;5278.947210527884;5279.574514880999;5282.65662731925;6176.505879529627;6176.660283684396;6178.783742569033;6184.350643182446;6186.783462578788;4093.8771836844944;4215.936760948588;4217.8312867485265;4221.409002739619;4446.822127114911;6335.366463353628;6398.104265402847;6455.4835613150835;6457.192850893638;6460.644664543495;4289.549597292302;4293.034067334887;4296.548862369469;4298.054428025829;4298.656107511454;4323.286657701507;4341.782910854445;4358.411614432011;4373.978130109393;4385.079133381962;5063.772130254148;5083.949160508421;5090.77091530882;5091.643584949018;5095.923561146586;6108.419700128481;6176.69116544171;6222.813315600449;6248.250209974832;6249.875002499924;1555.5255647027539;1562.4921900382194;1572.5911263071685;1575.2123938030984;1575.25962797485;999.5302207962246;1035.6168217759478;1063.803196408667;1083.1118482843992;1089.493385575711;5873.442023007808;5892.970535147297;5916;5967.254093238345;5969.880602387928;6353.5234857385885;6355;6368.617882926947;6369.522285828489;6370.0763389308295;5956.55325850563;5956.642601443928;5960.165576819249;5966.134910437962;5966.164736936832;3391.033555436689;3420.9486857697157;3422.931541369159;3424.07549961509;3426.2119712466274;6554.7378104876225;6680.5323627345615;6698.296678848651;6712.261651218362;6721.26066132725;6448.065030570541;6467.223933128054;6478.384553467413;6484.675766211671;6485.967570162119;6654.301298363699;6679.499037572202;6689.632070236184;6715.731370745116;6720.596764194066;6319.6208227506495;6343.143675603919;6353.555251132377;6357.90463143044;6364.6181229126405;6126.866529692022;6284.402981716729;6294.087357333069;6302.810915672537;6312.179416675986;6637.900431493628;6708.865822683617;6710.295418980937;6715.429188518835;6716.664166791738;4449.421575195204;4451.933221001623;4453.398791163281;4453.4433195850515;4458.643308535375;6336.20797400325;6336.619802811846;6340.71466784005;6341.841453963688;6346.682665866781;6143.477804386498;6161.322254551906;6163;6165.383461653978;6168.074788781719;6061.090836374579;6140.692965351625;6295.464885484785;6298.401651843067;6301.842453938688;6162.845928851814;6174.722137503733;6181.81454556364;6185.226846644169;6190.690465476618;6327.96836015817;6332.588381755171;6333.714982825692;6337.144485494399;6339.619622822645;5883.176355310346;6015.879682406415;6144.78493252734;6178.764247150498;6180.505559555135 13:21:31 INFO - PROCESS | 17648 | |5;yui.html;678.4504551313437;739.4675833399954;739.7410906182835;789.2147313423148;811.541479064329;13377.26425046622;13481.999999999987;13499.39252733627;13516.324183790795;13523.32383380832;12523.123381363308;12542.059345549098;12546.49814007441;12588.937055314711;12614.243145411281;666.2338310942431;805.2832978649008;823.4935514658472;824.3775949158377;828.6436832162168;811.7889348769304;824.4558591329694;824.47233770387;826.4462809917339;828.6892415344246;870.4429165334191;875.1773333066897;875.2166810704416;877.4691311756392;880.8942926848787;708.5996412027214;716.8709632266216;872.9650813967434;880.7930136417937;902.4224496322358;626.0734113512028;626.4330780643525;626.8119564130742;630.5239544144142;630.9211348581428;12957.22256664603;12992;12997.15518491295;13020.088593798439;13026.348682565835;11613;11628.302301861831;12153.270803751715;12208.206466579644;12469.314187719672;10651.201159913038;10743.731406714816;10849.945750271278;10975.176861735401;10981.450927453596;3566.5363502744735;3630.8366123524506;3695.9965831152276;3738.6822120119823;3739.6821270192067;48423.273650895266;49185;49438.75280623574;49461;49520.25719614208;9937.205023598095;10645.467726613639;10688.732781680364;10864.130869530418;11122.777544449227;18103.63792724138;18103.909480452778;18104.728429073573;18118.637627247383;18170;7617.6572054257695;7621.695132194761;7714.652840622185;7856;7859.51845139709;4498.730076195373;4564.7032942858605;4578.03861189154;4598.1033698429155;4624.05206932578;3050.8016978896744;3068.647105582842;3068.8772449102235;3075.6001719776286;3080.7997480163717;527.3882296536;535.2185808719313;546.551827501453;549.0254797733975;561.8033688209094;579.8840231953626;611.3550204534259;618.8298217990089;640.8814369341593;680.1769858471305;8211.83576328482;8321.251087402163;8560.828783424422;8644.654213831502;8828.337874659426;572.3932631410718;634.0710858592184;668.4518694670421;678.9083473731082;689.7516893918186;3746.6440688134585;3776.8489260429274;3784.413415920537;3828.808559572066;4000.57993910641;53422.46577534253;56154.43845561574;56410;56633.71683141558;56651;48224.27663585049;48467.27299090516;48584.27123593149;48918;50194.498055019714;42344.36483452751;43203.13593728108;43741.12517749627;43898.12203755971;43933.340999885666;8622.655093796178;8669.089745576624;8773.298136148966;8885.600147993226;8902.287816974756;32508.674913250565;33599.66400336063;33935.660643394236;34503.65496345004;35122.64877351296;42549;43176.784116079216;43699.34450983174;43954;44238.336424953006;11585.536578536765;11686.415679216176;11716.531338746696;11745.47145378443;11965.461554230254;12271.75456490883;12731.2997785119;12742.362881855684;13032.609021729364;13188.340582971005;11918.940405297919;11926.642200733992;11986.880131198577;12401.441935113122;12674.556390526655;11640.533466284433;11653.941730291293;11696.590619328283;11716.531338746696;11866.288022718665;11655.941720291345;11862.466189021343;11934.22427542207;12047.638570842888;12068;9389.765255868659;9783.41299522031;9880.35777674449;9970.202383809423;10115.848262275924;9090.863771641776;9257.629694812133;9405.576749046173;9436.95281523588;9852.408855468695 13:21:31 INFO - PROCESS | 17648 | __end_tp_report 13:21:31 INFO - PROCESS | 17648 | __start_cc_report 13:21:31 INFO - PROCESS | 17648 | _x_x_mozilla_cycle_collect,789 13:21:31 INFO - PROCESS | 17648 | __end_cc_report 13:21:31 INFO - PROCESS | 17648 | __startTimestamp1457731291040__endTimestamp 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | ------- Summary: start ------- 13:21:31 INFO - PROCESS | 17648 | Number of tests: 6 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#0] dojo.html Cycles:165 Average:5045.84 Median:5221.04 stddev:538.96 (10.3%) stddev-sans-first:519.31 13:21:31 INFO - PROCESS | 17648 | Values: 3133.5 3166.1 3196.6 3204.4 3225.4 4910.4 5001.0 5048.5 5073.3 5092.9 5049.8 5077.7 5082.8 5086.3 5113.8 4544.3 4582.6 4587.6 4715.3 4792.7 4522.0 4581.5 4701.6 4714.9 4782.2 4559.8 4589.4 4610.2 4626.6 4628.5 4570.0 4584.1 4585.4 4593.9 4648.1 4572.0 4579.0 4592.7 4628.6 4691.7 4929.5 4930.4 4945.0 4946.5 4980.2 5413.4 5416.3 5423.1 5425.1 5478.5 5398.7 5449.9 5466.3 5525.1 5525.5 5024.7 5031.3 5035.4 5038.8 5039.2 5454.8 5485.5 5486.7 5497.6 5529.9 5305.7 5330.9 5337.2 5363.6 5396.9 5364.5 5364.5 5367.4 5373.6 5374.6 5245.1 5337.7 5339.2 5344.4 5394.8 5407.8 5429.4 5446.8 5451.9 5491.1 4165.7 4176.6 4176.9 4177.2 4210.4 3713.4 3730.2 3782.0 3817.8 3833.5 5145.2 5156.2 5165.3 5199.4 5211.3 5435.8 5454.3 5460.9 5464.9 5500.2 5017.7 5082.8 5122.8 5158.5 5174.5 4675.0 4679.5 4680.2 4685.4 4722.6 5704.4 5716.1 5717.3 5722.4 5752.8 5321.5 5336.6 5405.1 5422.9 5437.0 5638.9 5662.1 5663.0 5664.3 5712.0 5352.4 5359.5 5363.0 5377.3 5414.8 5318.0 5442.3 5448.2 5523.8 5526.3 5205.2 5217.9 5222.7 5224.5 5224.6 5214.8 5221.0 5223.0 5229.9 5252.3 5115.2 5171.8 5190.7 5236.1 5250.0 5329.0 5360.4 5360.5 5367.3 5373.8 5158.8 5230.8 5256.6 5256.6 5299.4 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#1] ext.html Cycles:180 Average:42212.34 Median:17637.83 stddev:71548.63 (405.7%) stddev-sans-first:71680.76 13:21:31 INFO - PROCESS | 17648 | Values: 489.6 521.1 538.7 558.9 601.8 28128.2 28475.6 28595.7 28683.6 28694.7 36759.0 36936.8 36970.3 36996.4 37024.0 8457.5 8682.4 8689.4 8692.5 8694.2 7526.3 8439.7 8635.8 10247.9 10517.4 10234.5 10323.9 10335.7 10356.9 10365.6 10061.5 10133.8 10147.1 10168.7 10169.0 9877.7 10076.4 10082.7 10085.2 10085.5 36286.8 36669.3 36828.4 40586.2 40636.2 3570.9 3638.8 3654.2 3796.5 4007.4 30452.8 30512.0 30775.5 30844.2 31856.7 3210.7 3219.4 3241.2 3296.5 3351.2 290757.0 291439.0 292363.5 292462.0 293336.0 42065.4 42590.8 58803.7 59400.4 59457.7 40053.8 40096.0 40239.0 40252.8 40262.6 13154.8 13272.5 13276.1 13278.2 13286.4 9380.8 10201.8 10202.5 10247.6 10285.7 13947.9 14137.6 14148.6 14219.1 14224.2 5456.3 5545.7 5641.5 5670.7 5676.8 850.7 890.3 935.5 1023.4 1028.2 26696.7 26874.6 27237.7 28052.3 29073.1 996.7 1004.7 1006.9 1011.1 1055.3 14637.9 15167.2 15199.2 15244.5 15292.5 319917.0 322122.0 324735.0 325191.0 325485.0 52052.0 52628.7 52673.7 52745.2 52749.0 1286.0 1308.9 1322.7 1336.5 1405.2 25452.4 28651.3 28697.3 29177.6 29200.3 39236.8 39850.2 39924.4 39978.6 40027.8 183062.0 183744.0 183762.0 183779.0 184285.0 27305.0 31704.4 32027.0 32065.0 32314.5 37107.0 37548.2 37775.6 38115.0 38227.0 33587.0 34178.7 34430.3 34714.3 36013.3 34039.3 34157.5 34227.0 34314.0 34666.7 34398.7 34870.0 34945.0 35359.5 35530.3 29446.7 30851.7 30960.5 30978.8 31298.4 24108.2 24226.4 24244.3 24423.1 24666.6 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#2] jquery.html Cycles:180 Average:24311.35 Median:363.09 stddev:68885.05 (18971.8%) stddev-sans-first:69054.80 13:21:31 INFO - PROCESS | 17648 | Values: 351.3 360.8 365.4 366.6 371.5 16504.2 16533.9 17196.8 17199.4 17201.9 15430.8 15723.0 16001.3 16012.8 16016.9 5423.2 5467.2 5475.3 5550.1 5621.8 5485.6 5534.0 5548.5 5554.2 5574.2 5357.0 5439.9 5490.1 5491.9 5554.3 5427.7 5445.0 5450.7 5464.3 5467.9 4849.0 4890.2 4899.4 4904.9 4912.1 19901.8 20204.2 20467.1 20489.3 20602.6 2309.2 2591.0 2724.1 2915.9 2978.9 12954.2 13067.6 13249.9 13461.9 13509.6 1854.5 1854.6 1923.0 1932.5 2002.3 59365.4 59540.1 60130.0 60753.4 61015.4 9942.8 10062.2 10207.5 10330.1 10457.8 13564.7 13635.8 13675.1 13676.5 13708.9 7507.3 7561.2 7621.5 7697.7 7740.0 6987.1 7087.8 7095.8 7349.3 7593.3 6117.8 6159.8 6163.1 6229.2 6284.2 1771.1 1800.5 1806.4 1810.9 1848.5 920.5 938.4 972.7 979.1 1008.9 16734.0 16978.6 16979.6 17096.0 17141.7 914.1 924.7 926.6 929.8 941.9 9703.5 9936.6 9948.3 10028.9 10070.4 411262.0 415259.0 419674.0 431186.0 431470.0 46082.0 56338.7 61212.7 61986.4 65396.3 1025.9 1030.4 1036.8 1069.1 1070.1 15033.6 15184.2 15355.3 15543.2 15790.3 31308.4 31963.0 32144.7 32446.2 32574.0 43316.0 46031.3 46154.0 46321.8 47621.3 7474.1 7590.8 7700.9 7703.2 7739.9 9749.0 11530.5 11530.9 11553.6 11750.8 10163.5 10209.4 10280.2 10299.4 10324.6 9895.9 10001.9 10091.5 10164.3 10220.3 10239.3 10333.3 10418.8 10463.5 10500.1 7320.9 7362.7 7424.1 7496.0 7496.9 9127.5 10111.7 10119.0 10196.6 10290.1 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#3] mootools.html Cycles:180 Average:5360.90 Median:6519.95 stddev:2745.17 (42.1%) stddev-sans-first:2736.39 13:21:31 INFO - PROCESS | 17648 | Values: 1359.5 1451.2 1472.3 1632.2 1788.5 7149.6 7313.5 7319.6 7325.4 7329.6 7285.6 7443.6 7448.4 7452.3 7473.8 1956.2 2001.8 2207.6 2268.1 2309.3 2267.5 2270.1 2277.3 2277.9 2278.4 2187.8 2201.3 2244.1 2245.0 2245.7 2238.2 2243.5 2248.2 2251.5 2295.8 2245.5 2265.1 2282.3 2283.7 2286.6 7443.0 7483.6 7494.6 7499.0 7511.8 4667.7 4775.9 4787.4 4788.4 4790.5 2942.4 3093.5 3113.5 3158.1 3176.3 937.7 945.9 1019.8 1024.7 1053.2 10575.9 10642.7 10650.5 10653.9 10687.4 3975.9 4157.9 4217.6 4237.9 4252.3 8384.1 8434.3 8441.8 8473.7 8477.5 4612.1 4635.8 4646.9 4650.3 4654.5 3863.0 4260.9 4304.9 4333.7 4345.3 3423.6 3425.8 3494.3 3515.0 3535.7 995.1 1005.3 1013.6 1017.3 1044.8 1322.4 1335.6 1341.2 1356.2 1383.9 7037.9 7140.8 7166.9 7253.1 7384.0 1054.7 1076.2 1130.1 1137.9 1141.4 5750.8 5768.5 5811.8 5812.6 5818.9 8725.0 8854.9 9079.5 9179.7 9220.0 9156.7 9174.4 9274.1 9311.0 9365.6 6958.1 7128.4 7166.4 7167.9 7217.8 7165.2 7189.4 7214.7 7216.9 7247.7 7919.6 8126.0 8213.6 8261.8 8282.4 8137.8 8287.0 8419.7 8436.8 8439.4 6469.2 6567.1 6877.1 6941.6 6968.8 7407.8 7429.9 7462.6 7463.5 7479.9 6653.3 6823.9 6861.8 7034.8 7037.8 6744.5 6758.4 6811.4 6833.4 6891.2 6997.1 7056.6 7074.8 7103.9 7112.3 6501.5 6503.0 6516.5 6547.9 6552.6 6523.4 6533.5 6584.4 6596.7 6605.8 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#4] prototype.html Cycles:180 Average:5193.15 Median:5901.63 stddev:1561.78 (26.5%) stddev-sans-first:1523.25 13:21:31 INFO - PROCESS | 17648 | Values: 348.8 351.3 351.9 352.2 355.2 5799.9 5816.5 5853.0 5881.4 5910.3 5804.8 5814.9 5826.5 5832.2 5834.7 4324.8 4422.1 4547.8 4588.0 4595.2 4538.4 4560.9 4570.7 4577.3 4583.7 4363.1 4532.4 4534.9 4535.0 4539.4 4408.2 4505.9 4526.4 4533.5 4558.4 3972.9 4004.7 4015.5 4017.5 4031.2 5572.4 5583.4 5585.6 5595.3 5604.3 5275.2 5275.8 5278.9 5279.6 5282.7 6176.5 6176.7 6178.8 6184.4 6186.8 4093.9 4215.9 4217.8 4221.4 4446.8 6335.4 6398.1 6455.5 6457.2 6460.6 4289.5 4293.0 4296.5 4298.1 4298.7 4323.3 4341.8 4358.4 4374.0 4385.1 5063.8 5083.9 5090.8 5091.6 5095.9 6108.4 6176.7 6222.8 6248.3 6249.9 1555.5 1562.5 1572.6 1575.2 1575.3 999.5 1035.6 1063.8 1083.1 1089.5 5873.4 5893.0 5916.0 5967.3 5969.9 6353.5 6355.0 6368.6 6369.5 6370.1 5956.6 5956.6 5960.2 5966.1 5966.2 3391.0 3420.9 3422.9 3424.1 3426.2 6554.7 6680.5 6698.3 6712.3 6721.3 6448.1 6467.2 6478.4 6484.7 6486.0 6654.3 6679.5 6689.6 6715.7 6720.6 6319.6 6343.1 6353.6 6357.9 6364.6 6126.9 6284.4 6294.1 6302.8 6312.2 6637.9 6708.9 6710.3 6715.4 6716.7 4449.4 4451.9 4453.4 4453.4 4458.6 6336.2 6336.6 6340.7 6341.8 6346.7 6143.5 6161.3 6163.0 6165.4 6168.1 6061.1 6140.7 6295.5 6298.4 6301.8 6162.8 6174.7 6181.8 6185.2 6190.7 6328.0 6332.6 6333.7 6337.1 6339.6 5883.2 6015.9 6144.8 6178.8 6180.5 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - PROCESS | 17648 | [#5] yui.html Cycles:180 Average:13659.22 Median:4531.72 stddev:15452.16 (341.0%) stddev-sans-first:15464.76 13:21:31 INFO - PROCESS | 17648 | Values: 678.5 739.5 739.7 789.2 811.5 13377.3 13482.0 13499.4 13516.3 13523.3 12523.1 12542.1 12546.5 12588.9 12614.2 666.2 805.3 823.5 824.4 828.6 811.8 824.5 824.5 826.4 828.7 870.4 875.2 875.2 877.5 880.9 708.6 716.9 873.0 880.8 902.4 626.1 626.4 626.8 630.5 630.9 12957.2 12992.0 12997.2 13020.1 13026.3 11613.0 11628.3 12153.3 12208.2 12469.3 10651.2 10743.7 10849.9 10975.2 10981.5 3566.5 3630.8 3696.0 3738.7 3739.7 48423.3 49185.0 49438.8 49461.0 49520.3 9937.2 10645.5 10688.7 10864.1 11122.8 18103.6 18103.9 18104.7 18118.6 18170.0 7617.7 7621.7 7714.7 7856.0 7859.5 4498.7 4564.7 4578.0 4598.1 4624.1 3050.8 3068.6 3068.9 3075.6 3080.8 527.4 535.2 546.6 549.0 561.8 579.9 611.4 618.8 640.9 680.2 8211.8 8321.3 8560.8 8644.7 8828.3 572.4 634.1 668.5 678.9 689.8 3746.6 3776.8 3784.4 3828.8 4000.6 53422.5 56154.4 56410.0 56633.7 56651.0 48224.3 48467.3 48584.3 48918.0 50194.5 42344.4 43203.1 43741.1 43898.1 43933.3 8622.7 8669.1 8773.3 8885.6 8902.3 32508.7 33599.7 33935.7 34503.7 35122.6 42549.0 43176.8 43699.3 43954.0 44238.3 11585.5 11686.4 11716.5 11745.5 11965.5 12271.8 12731.3 12742.4 13032.6 13188.3 11918.9 11926.6 11986.9 12401.4 12674.6 11640.5 11653.9 11696.6 11716.5 11866.3 11655.9 11862.5 11934.2 12047.6 12068.0 9389.8 9783.4 9880.4 9970.2 10115.8 9090.9 9257.6 9405.6 9437.0 9852.4 13:21:31 INFO - PROCESS | 17648 | -------- Summary: end -------- 13:21:31 INFO - PROCESS | 17648 | 13:21:31 INFO - TEST-INFO | 17648: exit 0 13:21:31 INFO - TEST-OK | dromaeo_css | took 1112873ms 13:21:31 INFO - TEST-START | kraken 13:21:31 INFO - operating with platform_type : linux_ 13:21:31 INFO - Initialising browser for kraken test... 13:21:31 INFO - TEST-INFO | started process 17837 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDDHuK9/profile http://localhost:60833/getInfo.html) 13:21:35 INFO - PROCESS | 17837 | __metrics Screen width/height:1600/1200 13:21:35 INFO - PROCESS | 17837 | colorDepth:24 13:21:35 INFO - PROCESS | 17837 | Browser inner width/height: 1024/697 13:21:35 INFO - PROCESS | 17837 | __metrics 13:21:36 ERROR - PROCESS | 17837 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:21:36 INFO - PROCESS | 17837 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:21:37 INFO - TEST-INFO | 17837: exit 0 13:21:37 INFO - Browser initialized. 13:21:37 INFO - Running cycle 1/1 for kraken test... 13:21:37 INFO - TEST-INFO | started process 17921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDDHuK9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:49 INFO - PROCESS | 17921 | RSS: Main: 155054080 13:21:49 INFO - PROCESS | 17921 | 13:21:52 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60833/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:52 INFO - PROCESS | 17921 | RSS: Main: 194629632 13:21:52 INFO - PROCESS | 17921 | 13:21:55 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60833/tests/kraken/driver.html?testName=audio-dft) 13:21:55 INFO - PROCESS | 17921 | RSS: Main: 185737216 13:21:55 INFO - PROCESS | 17921 | 13:21:58 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60833/tests/kraken/driver.html?testName=audio-fft) 13:21:59 INFO - PROCESS | 17921 | RSS: Main: 172228608 13:21:59 INFO - PROCESS | 17921 | 13:22:01 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60833/tests/kraken/driver.html?testName=audio-oscillator) 13:22:02 INFO - PROCESS | 17921 | RSS: Main: 174235648 13:22:02 INFO - PROCESS | 17921 | 13:22:04 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:04 INFO - PROCESS | 17921 | RSS: Main: 174206976 13:22:04 INFO - PROCESS | 17921 | 13:22:07 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60833/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:08 INFO - PROCESS | 17921 | RSS: Main: 175394816 13:22:08 INFO - PROCESS | 17921 | 13:22:11 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60833/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:12 INFO - PROCESS | 17921 | RSS: Main: 175431680 13:22:12 INFO - PROCESS | 17921 | 13:22:15 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60833/tests/kraken/driver.html?testName=json-parse-financial) 13:22:15 INFO - PROCESS | 17921 | RSS: Main: 176943104 13:22:15 INFO - PROCESS | 17921 | 13:22:17 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:18 INFO - PROCESS | 17921 | RSS: Main: 183033856 13:22:18 INFO - PROCESS | 17921 | 13:22:19 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:20 INFO - PROCESS | 17921 | RSS: Main: 179650560 13:22:20 INFO - PROCESS | 17921 | 13:22:22 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:23 INFO - PROCESS | 17921 | RSS: Main: 191889408 13:22:23 INFO - PROCESS | 17921 | 13:22:25 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:26 INFO - PROCESS | 17921 | RSS: Main: 197550080 13:22:26 INFO - PROCESS | 17921 | 13:22:28 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:29 INFO - PROCESS | 17921 | RSS: Main: 198103040 13:22:29 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | Cycle 1(1): loaded http://localhost:60833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60833/tests/kraken/driver.html?testName=ai-astar) 13:22:31 INFO - PROCESS | 17921 | RSS: Main: 257785856 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | __start_tp_report 13:22:31 INFO - PROCESS | 17921 | _x_x_mozilla_page_load 13:22:31 INFO - PROCESS | 17921 | _x_x_mozilla_page_load_details 13:22:31 INFO - PROCESS | 17921 | |i|pagename|runs| 13:22:31 INFO - PROCESS | 17921 | |0;ai-astar;110;111;107;111;112;111;101;112;110;111 13:22:31 INFO - PROCESS | 17921 | |1;audio-beat-detection;154;127;150;174;127;156;150;128;167;129 13:22:31 INFO - PROCESS | 17921 | |2;audio-dft;163;161;161;160;161;162;162;164;164;163 13:22:31 INFO - PROCESS | 17921 | |3;audio-fft;77;74;120;96;76;76;77;115;93;73 13:22:31 INFO - PROCESS | 17921 | |4;audio-oscillator;94;96;151;94;94;94;142;94;93;140 13:22:31 INFO - PROCESS | 17921 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;116 13:22:31 INFO - PROCESS | 17921 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 13:22:31 INFO - PROCESS | 17921 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;95;95 13:22:31 INFO - PROCESS | 17921 | |8;json-parse-financial;60;56;54;56;55;56;57;65;54;54 13:22:31 INFO - PROCESS | 17921 | |9;json-stringify-tinderbox;68;69;69;68;68;68;69;69;69;69 13:22:31 INFO - PROCESS | 17921 | |10;stanford-crypto-aes;90;83;82;82;89;80;82;82;82;81 13:22:31 INFO - PROCESS | 17921 | |11;stanford-crypto-ccm;119;116;128;114;117;113;124;116;120;118 13:22:31 INFO - PROCESS | 17921 | |12;stanford-crypto-pbkdf2;152;141;155;146;149;155;150;151;152;145 13:22:31 INFO - PROCESS | 17921 | |13;stanford-crypto-sha256-iterative;73;69;69;68;69;68;67;68;67;67 13:22:31 INFO - PROCESS | 17921 | __end_tp_report 13:22:31 INFO - PROCESS | 17921 | __start_cc_report 13:22:31 INFO - PROCESS | 17921 | _x_x_mozilla_cycle_collect,1079 13:22:31 INFO - PROCESS | 17921 | __end_cc_report 13:22:31 INFO - PROCESS | 17921 | __startTimestamp1457731351263__endTimestamp 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | ------- Summary: start ------- 13:22:31 INFO - PROCESS | 17921 | Number of tests: 14 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.34 (3.0%) stddev-sans-first:3.54 13:22:31 INFO - PROCESS | 17921 | Values: 110.0 111.0 107.0 111.0 112.0 111.0 101.0 112.0 110.0 111.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:152.00 stddev:17.50 (11.5%) stddev-sans-first:18.33 13:22:31 INFO - PROCESS | 17921 | Values: 154.0 127.0 150.0 174.0 127.0 156.0 150.0 128.0 167.0 129.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 13:22:31 INFO - PROCESS | 17921 | Values: 163.0 161.0 161.0 160.0 161.0 162.0 162.0 164.0 164.0 163.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#3] audio-fft Cycles:10 Average:87.70 Median:76.50 stddev:17.61 (23.0%) stddev-sans-first:18.25 13:22:31 INFO - PROCESS | 17921 | Values: 77.0 74.0 120.0 96.0 76.0 76.0 77.0 115.0 93.0 73.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.41 (26.0%) stddev-sans-first:25.27 13:22:31 INFO - PROCESS | 17921 | Values: 94.0 96.0 151.0 94.0 94.0 94.0 142.0 94.0 93.0 140.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:22:31 INFO - PROCESS | 17921 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:22:31 INFO - PROCESS | 17921 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:22:31 INFO - PROCESS | 17921 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.43 (6.1%) stddev-sans-first:3.43 13:22:31 INFO - PROCESS | 17921 | Values: 60.0 56.0 54.0 56.0 55.0 56.0 57.0 65.0 54.0 54.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 13:22:31 INFO - PROCESS | 17921 | Values: 68.0 69.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:3.37 (4.1%) stddev-sans-first:2.55 13:22:31 INFO - PROCESS | 17921 | Values: 90.0 83.0 82.0 82.0 89.0 80.0 82.0 82.0 82.0 81.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:4.58 (3.9%) stddev-sans-first:4.85 13:22:31 INFO - PROCESS | 17921 | Values: 119.0 116.0 128.0 114.0 117.0 113.0 124.0 116.0 120.0 118.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:151.50 stddev:4.48 (3.0%) stddev-sans-first:4.66 13:22:31 INFO - PROCESS | 17921 | Values: 152.0 141.0 155.0 146.0 149.0 155.0 150.0 151.0 152.0 145.0 13:22:31 INFO - PROCESS | 17921 | 13:22:31 INFO - PROCESS | 17921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.78 (2.6%) stddev-sans-first:0.87 13:22:31 INFO - PROCESS | 17921 | Values: 73.0 69.0 69.0 68.0 69.0 68.0 67.0 68.0 67.0 67.0 13:22:31 INFO - PROCESS | 17921 | -------- Summary: end -------- 13:22:31 INFO - PROCESS | 17921 | 13:22:32 INFO - TEST-INFO | 17921: exit 0 13:22:32 INFO - TEST-OK | kraken | took 60448ms 13:22:32 INFO - SUITE-END | took 1173s 13:22:32 INFO - Completed test suite (00:19:33) 13:22:32 INFO - javascript benchmark 13:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3133.514305282681, 3166.113488223298, 3196.5524826524293, 3204.3591281743643, 3225.354929014197, 4910.361652985116, 5001.0, 5048.545630893219, 5073.2643766653855, 5092.898142037157, 5049.772760225789, 5077.6953382797055, 5082.847514574569, 5086.313347698059, 5113.846584602468, 4544.272916333395, 4582.587567118959, 4587.587117159455, 4715.269133284346, 4792.7124372537755, 4522.0, 4581.541845815425, 4701.576858082772, 4714.90570188596, 4782.210935195689, 4559.794809233559, 4589.403377560929, 4610.170169369512, 4626.606738427204, 4628.537146285362, 4569.977150114261, 4584.106099310636, 4585.449746030497, 4593.885152871171, 4648.1168577970075, 4572.039871626962, 4578.954210457886, 4592.747398893093, 4628.629709623222, 4691.741954192518, 4929.482404347564, 4930.433000204951, 4945.0, 4946.480619534969, 4980.178270585386, 5413.404525502192, 5416.322959630046, 5423.105187644034, 5425.131978883399, 5478.479544443271, 5398.73006349681, 5449.891002179974, 5466.34403871538, 5525.11598144295, 5525.502704756591, 5024.748762561857, 5031.345925029759, 5035.395752509722, 5038.823641172541, 5039.21892106724, 5454.781808727606, 5485.50630443262, 5486.6982315973, 5497.5601951843755, 5529.861753456195, 5305.681659100389, 5330.92003619946, 5337.172738225581, 5363.570914326844, 5396.946030539723, 5364.463553644604, 5364.463553644604, 5367.355917289872, 5373.596980226499, 5374.623776335619, 5245.10833158364, 5337.733113344318, 5339.199120132012, 5344.412114667383, 5394.78420863169, 5407.756650950717, 5429.375621803464, 5446.809361672402, 5451.945480545223, 5491.121420572689, 4165.729227600196, 4176.582341765799, 4176.853810116631, 4177.185448837447, 4210.431591735077, 3713.405855063177, 3730.198007428416, 3782.016675664292, 3817.828197731109, 3833.4824798651825, 5145.228215767665, 5156.1750119980625, 5165.276861239429, 5199.4020687621405, 5211.322528071327, 5435.83692489226, 5454.290942177571, 5460.918086228709, 5464.9453505465235, 5500.1749737538885, 5017.749112544431, 5082.847514574569, 5122.820701275437, 5158.535731784157, 5174.534291913746, 4674.95325046752, 4679.485256621769, 4680.227762419163, 4685.437747470257, 4722.574968252874, 5704.372519022904, 5716.08542633185, 5717.313922329347, 5722.4277572242445, 5752.827415177551, 5321.494458026481, 5336.573074154136, 5405.054115529845, 5422.864428389322, 5436.972815136057, 5638.85902852432, 5662.094064949588, 5663.0, 5664.26364572603, 5712.0, 5352.437994010573, 5359.490848369399, 5363.0, 5377.327834020747, 5414.810481633124, 5318.0, 5442.292501974718, 5448.182772584144, 5523.834284971457, 5526.253955715927, 5205.219217117463, 5217.895642087061, 5222.738863056908, 5224.52979231871, 5224.582033437392, 5214.791408343775, 5221.039237322713, 5223.033738758342, 5229.895402091861, 5252.317198764136, 5115.2071428928575, 5171.844844654666, 5190.740462976912, 5236.057509648148, 5249.973750131225, 5328.960852633699, 5360.43715409892, 5360.490753378423, 5367.329083864517, 5373.7850485980125, 5158.767855446589, 5230.8169214077325, 5256.605754568346, 5256.6320357574605, 5299.417064122867], "unit": "score", "name": "dojo.html", "value": 5012.905320142216}, {"lowerIsBetter": false, "replicates": [489.6180978836509, 521.0568870344674, 538.6687187379763, 558.8574913397083, 601.8074216250799, 28128.156155315348, 28475.572866406994, 28595.714042859567, 28683.569746453766, 28694.713052869516, 36759.0, 36936.815315923384, 36970.26059478809, 36996.44505332422, 37024.0, 8457.492550446992, 8682.392232543725, 8689.391742578022, 8692.47845129291, 8694.17405346491, 7526.322630963212, 8439.70461033864, 8635.784105397352, 10247.897521024768, 10517.368957862553, 10234.53944572496, 10323.896761032369, 10335.689929302096, 10356.896431035706, 10365.637202697908, 10061.547230374614, 10133.797324053552, 10147.086762191439, 10168.745781355452, 10169.0, 9877.703668889944, 10076.395416275047, 10082.69751907444, 10085.243606729451, 10085.49572521371, 36286.81856590726, 36669.266614667824, 36828.44757328642, 40586.18827623461, 40636.187276254605, 3570.8571657133684, 3638.7998660073686, 3654.214343916044, 3796.4814074370474, 4007.3988901664984, 30452.84773576118, 30512.04265946413, 30775.538366924513, 30844.22889427782, 31856.681433185604, 3210.6628803975714, 3219.404410184123, 3241.1897025743565, 3296.5220043093855, 3351.162209447638, 290757.0, 291439.0, 292363.5381823098, 292462.0, 293336.0, 42065.369019464735, 42590.78704606457, 58803.70598147067, 59400.40599593949, 59457.70271148616, 40053.79973100174, 40096.0, 40239.0, 40252.79873600672, 40262.597374025885, 13154.802677959839, 13272.535461258809, 13276.137051091648, 13278.20330780137, 13286.402111904987, 9380.765480862896, 10201.795964080677, 10202.489875506195, 10247.59009639621, 10285.7428564285, 13947.930260348634, 14137.575872723835, 14148.64628384278, 14219.075760075562, 14224.21766802815, 5456.290682211287, 5545.694986775766, 5641.52047075995, 5670.688112153871, 5676.801311954062, 850.7107583421666, 890.2966656341417, 935.5462600638684, 1023.4268809466722, 1028.228828378716, 26696.733032669814, 26874.5968810468, 27237.727622723916, 28052.29869253285, 29073.127806165427, 996.7059717383389, 1004.6634377483625, 1006.8892421833592, 1011.1354791653031, 1055.3456856748865, 14637.853621463863, 15167.208197950513, 15199.184255335851, 15244.542663720105, 15292.464763733216, 319917.0, 322122.0, 324735.0, 325191.0, 325485.0, 52052.0, 52628.736856315474, 52673.73663131736, 52745.2088218677, 52749.0, 1285.958373717292, 1308.9214647121203, 1322.6561094115407, 1336.492132989477, 1405.1779708870222, 25452.363690907136, 28651.28371790722, 28697.28256793597, 29177.562336565392, 29200.26999325034, 39236.80381598188, 39850.20299593934, 39924.401133982436, 39978.60021399749, 40027.79986100051, 183062.0, 183744.0, 183762.0, 183779.0, 184285.0, 27305.0, 31704.36591268208, 32027.0, 32065.0, 32314.515282270313, 37107.0, 37548.2490350186, 37775.62224377721, 38115.0, 38227.0, 33587.0, 34178.65821341755, 34430.311393772485, 34714.30571388609, 36013.27973440569, 34039.31921361609, 34157.48763768496, 34227.0, 34314.0, 34666.65333346634, 34398.65601343955, 34870.0, 34945.0, 35359.46960795642, 35530.28939421249, 29446.705532944397, 30851.69148308488, 30960.53559196659, 30978.845105774326, 31298.374032519678, 24108.156214532406, 24226.394340141636, 24244.272671819872, 24423.14518991827, 24666.630000550365], "unit": "score", "name": "ext.html", "value": 17199.16111945456}, {"lowerIsBetter": false, "replicates": [351.33597500723636, 360.7961501751511, 365.3879751416377, 366.5912507554077, 371.5263039624477, 16504.174791260433, 16533.917330413347, 17196.82803171968, 17199.398021069264, 17201.88187767796, 15430.768538471904, 15723.0, 16001.27994240259, 16012.83987160128, 16016.919915400407, 5423.159410291411, 5467.234587157791, 5475.260839786618, 5550.111982082867, 5621.80323688671, 5485.588580856432, 5534.03154447972, 5548.500634942854, 5554.19464177696, 5574.247476590669, 5356.9732151339185, 5439.864003399907, 5490.121580547113, 5491.917621235664, 5554.2779438672915, 5427.674339539621, 5445.047116754592, 5450.727463626803, 5464.3442786865635, 5467.917981230285, 4849.0, 4890.217565189552, 4899.363082799249, 4904.926426103611, 4912.066707325596, 19901.800981990284, 20204.19183232669, 20467.07898144587, 20489.28287509945, 20602.58794824095, 2309.2494939144676, 2590.9870450647813, 2724.101046654599, 2915.8833646654107, 2978.8659510322086, 12954.222746635138, 13067.607971760863, 13249.86750132496, 13461.932690336584, 13509.59471215865, 1854.4992851929903, 1854.6105317883262, 1922.9903850480798, 1932.5072106612865, 2002.2591641092888, 59365.40634593642, 59540.10689839656, 60130.0, 60753.392466075216, 61015.38984610186, 9942.751431214278, 10062.19502439803, 10207.489625518694, 10330.121939635064, 10457.790844183226, 13564.728705425836, 13635.795463068062, 13675.111117777511, 13676.452941882413, 13708.862911370958, 7507.253503811163, 7561.2060733623275, 7621.50460220095, 7697.730579429693, 7739.955106060723, 6987.056747339146, 7087.82280442993, 7095.751648692374, 7349.338559529561, 7593.278638529331, 6117.816465506042, 6159.784407545714, 6163.075538669146, 6229.159063526366, 6284.183056202756, 1771.0967406622458, 1800.5048611631905, 1806.3677712800416, 1810.9456716298532, 1848.5378655336167, 920.4799288402031, 938.3666025432806, 972.6838777397375, 979.118793086228, 1008.8537162111453, 16734.0, 16978.57553561146, 16979.575510612085, 17095.99064383597, 17141.657166856843, 914.0996118822954, 924.67174153176, 926.6478738079621, 929.818685356349, 941.9058094190664, 9703.466309353053, 9936.602535898628, 9948.303618746762, 10028.899711002796, 10070.395776253448, 411262.0, 415259.0, 419674.0, 431186.0, 431470.0, 46082.0, 56338.71830640903, 61212.69393653092, 61986.38013619806, 65396.34603653998, 1025.9127974122134, 1030.4023666273692, 1036.8133735927606, 1069.13934282903, 1070.0583486531957, 15033.624159396102, 15184.240787960778, 15355.309011094305, 15543.222838858239, 15790.289436975594, 31308.373832522768, 31963.0, 32144.678553215104, 32446.188845279055, 32574.0, 43316.0, 46031.309530356404, 46154.0, 46321.84195395142, 47621.28568071412, 7474.14047384536, 7590.7722768317035, 7700.8844867325915, 7703.152653208031, 7739.92260077392, 9748.951255243679, 11530.481128349076, 11530.94234528822, 11553.595624153451, 11750.764984700429, 10163.491825408848, 10209.38743675382, 10280.177585793268, 10299.3820370778, 10324.638637647646, 9895.901040989498, 10001.949990250294, 10091.495425228855, 10164.288499804943, 10220.335678180894, 10239.283250172417, 10333.276670632984, 10418.843717344398, 10463.476826158509, 10500.054995050483, 7320.890186647098, 7362.7054917804835, 7424.071991001125, 7496.0, 7496.9250307498405, 9127.497987610745, 10111.696649100539, 10119.0, 10196.643117490852, 10290.12533934624], "unit": "score", "name": "jquery.html", "value": 8399.221093685877}, {"lowerIsBetter": false, "replicates": [1359.4901911783081, 1451.2453524167433, 1472.3006571878357, 1632.2165360626898, 1788.5171003828966, 7149.606771627558, 7313.488055836094, 7319.560826350423, 7325.377342925858, 7329.633518324089, 7285.635718214095, 7443.627818609075, 7448.404127669787, 7452.254774522558, 7473.775786726394, 1956.1979588368772, 2001.7998200180011, 2207.635740102889, 2268.0587556164173, 2309.2956648222284, 2267.489814791675, 2270.103309192868, 2277.3054218463362, 2277.851939623919, 2278.3734473019886, 2187.84685072045, 2201.2625770366944, 2244.0911430870524, 2244.9551008979893, 2245.6743772153027, 2238.2278114050628, 2243.4952135769486, 2248.2243625949022, 2251.549690061986, 2295.781900719429, 2245.4610893385634, 2265.0713207584813, 2282.2582660635194, 2283.7145356830397, 2286.5998450271136, 7442.962785186093, 7483.588402637853, 7494.550326980344, 7499.0, 7511.849763004764, 4667.6732628716, 4775.928361074587, 4787.40157480315, 4788.425388953313, 4790.520947905216, 2942.3820997590533, 3093.4586447371844, 3113.4551453495546, 3158.0683698309053, 3176.332970076264, 937.7421209167534, 945.8628498867625, 1019.8470229465565, 1024.7335692719946, 1053.1627356251797, 10575.947120264427, 10642.680719578348, 10650.520726567323, 10653.9467302663, 10687.412192329497, 3975.940360894589, 4157.854475093357, 4217.557156498585, 4237.936430953539, 4252.340887162495, 8384.077751447336, 8434.28308593764, 8441.788955276168, 8473.661053557911, 8477.533735644476, 4612.077584483117, 4635.791389387486, 4646.93120582268, 4650.255959046536, 4654.534546545318, 3863.0, 4260.914781704349, 4304.935425968613, 4333.739975601474, 4345.304751239786, 3423.5549378580627, 3425.760196786201, 3494.3186078714916, 3514.9824250878582, 3535.7171426285836, 995.069609914732, 1005.2862467647906, 1013.614826365991, 1017.3336464615688, 1044.7805960748176, 1322.444573279225, 1335.599320203935, 1341.235495767403, 1356.1727346318737, 1383.9377228024764, 7037.929620703728, 7140.7857764267155, 7166.856662866713, 7253.057102576631, 7384.0, 1054.7099547624312, 1076.1821016027875, 1130.0846314485293, 1137.8919002694731, 1141.366541569437, 5750.827475175752, 5768.538516918637, 5811.79658711943, 5812.564057695689, 5818.883622327529, 8725.0, 8854.893138357706, 9079.546022698838, 9179.724608261762, 9220.0, 9156.725298241063, 9174.449533028039, 9274.118958698913, 9310.953445232866, 9365.625374984924, 6958.06066181059, 7128.358447739624, 7166.355028047501, 7167.928320716726, 7217.783466496118, 7165.176004759519, 7189.388901943394, 7214.74748383804, 7216.927830721836, 7247.673854676446, 7919.604019799102, 8126.0, 8213.630386632736, 8261.83476330482, 8282.4202305838, 8137.79655508617, 8287.0, 8419.663213471393, 8436.789080273042, 8439.367047471587, 6469.191351081115, 6567.113439685581, 6877.140357455318, 6941.583504989515, 6968.756093536702, 7407.8148046299275, 7429.888551671837, 7462.626868656654, 7463.477556570988, 7479.925200748141, 6653.334666533308, 6823.874060779915, 6861.794146175623, 7034.753783617549, 7037.824054398477, 6744.494162937701, 6758.3917447428, 6811.421029212573, 6833.4191593715095, 6891.173059232924, 6997.1253593300835, 7056.6118863463, 7074.787756367317, 7103.9289607103265, 7112.288771122846, 6501.512386570931, 6502.967485162544, 6516.478681705357, 6547.934520654923, 6552.63960482178, 6523.412892839668, 6533.477321814148, 6584.407403333723, 6596.670166491752, 6605.834854128685], "unit": "score", "name": "mootools.html", "value": 4420.335297979942}, {"lowerIsBetter": false, "replicates": [348.7645839058638, 351.3219486391264, 351.9348920449717, 352.1794219468638, 355.17244819570396, 5799.855003624912, 5816.476517113459, 5852.970735146329, 5881.382454842244, 5910.290765108193, 5804.7968321108665, 5814.912776308348, 5826.533877289818, 5832.154337621042, 5834.737436815343, 4324.805383757731, 4422.11557688462, 4547.772611369418, 4587.977060114711, 4595.241785105453, 4538.410006699124, 4560.8859778505475, 4570.680052396334, 4577.313402989545, 4583.679142460029, 4363.083752411997, 4532.365468834366, 4534.9319760203625, 4534.9773251133865, 4539.432570928634, 4408.20652282589, 4505.909881802379, 4526.388937493429, 4533.5013148553635, 4558.38461807655, 3972.940405893914, 4004.659603933669, 4015.4779878615886, 4017.517897852247, 4031.21391328691, 5572.3870374258795, 5583.3858275589655, 5585.636933599303, 5595.328560572717, 5604.271444712162, 5275.155975043975, 5275.841724748264, 5278.947210527884, 5279.574514880999, 5282.65662731925, 6176.505879529627, 6176.660283684396, 6178.783742569033, 6184.350643182446, 6186.783462578788, 4093.8771836844944, 4215.936760948588, 4217.8312867485265, 4221.409002739619, 4446.822127114911, 6335.366463353628, 6398.104265402847, 6455.4835613150835, 6457.192850893638, 6460.644664543495, 4289.549597292302, 4293.034067334887, 4296.548862369469, 4298.054428025829, 4298.656107511454, 4323.286657701507, 4341.782910854445, 4358.411614432011, 4373.978130109393, 4385.079133381962, 5063.772130254148, 5083.949160508421, 5090.77091530882, 5091.643584949018, 5095.923561146586, 6108.419700128481, 6176.69116544171, 6222.813315600449, 6248.250209974832, 6249.875002499924, 1555.5255647027539, 1562.4921900382194, 1572.5911263071685, 1575.2123938030984, 1575.25962797485, 999.5302207962246, 1035.6168217759478, 1063.803196408667, 1083.1118482843992, 1089.493385575711, 5873.442023007808, 5892.970535147297, 5916.0, 5967.254093238345, 5969.880602387928, 6353.5234857385885, 6355.0, 6368.617882926947, 6369.522285828489, 6370.0763389308295, 5956.55325850563, 5956.642601443928, 5960.165576819249, 5966.134910437962, 5966.164736936832, 3391.033555436689, 3420.9486857697157, 3422.931541369159, 3424.07549961509, 3426.2119712466274, 6554.7378104876225, 6680.5323627345615, 6698.296678848651, 6712.261651218362, 6721.26066132725, 6448.065030570541, 6467.223933128054, 6478.384553467413, 6484.675766211671, 6485.967570162119, 6654.301298363699, 6679.499037572202, 6689.632070236184, 6715.731370745116, 6720.596764194066, 6319.6208227506495, 6343.143675603919, 6353.555251132377, 6357.90463143044, 6364.6181229126405, 6126.866529692022, 6284.402981716729, 6294.087357333069, 6302.810915672537, 6312.179416675986, 6637.900431493628, 6708.865822683617, 6710.295418980937, 6715.429188518835, 6716.664166791738, 4449.421575195204, 4451.933221001623, 4453.398791163281, 4453.4433195850515, 4458.643308535375, 6336.20797400325, 6336.619802811846, 6340.71466784005, 6341.841453963688, 6346.682665866781, 6143.477804386498, 6161.322254551906, 6163.0, 6165.383461653978, 6168.074788781719, 6061.090836374579, 6140.692965351625, 6295.464885484785, 6298.401651843067, 6301.842453938688, 6162.845928851814, 6174.722137503733, 6181.81454556364, 6185.226846644169, 6190.690465476618, 6327.96836015817, 6332.588381755171, 6333.714982825692, 6337.144485494399, 6339.619622822645, 5883.176355310346, 6015.879682406415, 6144.78493252734, 6178.764247150498, 6180.505559555135], "unit": "score", "name": "prototype.html", "value": 4692.3102313695135}, {"lowerIsBetter": false, "replicates": [678.4504551313437, 739.4675833399954, 739.7410906182835, 789.2147313423148, 811.541479064329, 13377.26425046622, 13481.999999999987, 13499.39252733627, 13516.324183790795, 13523.32383380832, 12523.123381363308, 12542.059345549098, 12546.49814007441, 12588.937055314711, 12614.243145411281, 666.2338310942431, 805.2832978649008, 823.4935514658472, 824.3775949158377, 828.6436832162168, 811.7889348769304, 824.4558591329694, 824.47233770387, 826.4462809917339, 828.6892415344246, 870.4429165334191, 875.1773333066897, 875.2166810704416, 877.4691311756392, 880.8942926848787, 708.5996412027214, 716.8709632266216, 872.9650813967434, 880.7930136417937, 902.4224496322358, 626.0734113512028, 626.4330780643525, 626.8119564130742, 630.5239544144142, 630.9211348581428, 12957.22256664603, 12992.0, 12997.15518491295, 13020.088593798439, 13026.348682565835, 11613.0, 11628.302301861831, 12153.270803751715, 12208.206466579644, 12469.314187719672, 10651.201159913038, 10743.731406714816, 10849.945750271278, 10975.176861735401, 10981.450927453596, 3566.5363502744735, 3630.8366123524506, 3695.9965831152276, 3738.6822120119823, 3739.6821270192067, 48423.273650895266, 49185.0, 49438.75280623574, 49461.0, 49520.25719614208, 9937.205023598095, 10645.467726613639, 10688.732781680364, 10864.130869530418, 11122.777544449227, 18103.63792724138, 18103.909480452778, 18104.728429073573, 18118.637627247383, 18170.0, 7617.6572054257695, 7621.695132194761, 7714.652840622185, 7856.0, 7859.51845139709, 4498.730076195373, 4564.7032942858605, 4578.03861189154, 4598.1033698429155, 4624.05206932578, 3050.8016978896744, 3068.647105582842, 3068.8772449102235, 3075.6001719776286, 3080.7997480163717, 527.3882296536, 535.2185808719313, 546.551827501453, 549.0254797733975, 561.8033688209094, 579.8840231953626, 611.3550204534259, 618.8298217990089, 640.8814369341593, 680.1769858471305, 8211.83576328482, 8321.251087402163, 8560.828783424422, 8644.654213831502, 8828.337874659426, 572.3932631410718, 634.0710858592184, 668.4518694670421, 678.9083473731082, 689.7516893918186, 3746.6440688134585, 3776.8489260429274, 3784.413415920537, 3828.808559572066, 4000.57993910641, 53422.46577534253, 56154.43845561574, 56410.0, 56633.71683141558, 56651.0, 48224.27663585049, 48467.27299090516, 48584.27123593149, 48918.0, 50194.498055019714, 42344.36483452751, 43203.13593728108, 43741.12517749627, 43898.12203755971, 43933.340999885666, 8622.655093796178, 8669.089745576624, 8773.298136148966, 8885.600147993226, 8902.287816974756, 32508.674913250565, 33599.66400336063, 33935.660643394236, 34503.65496345004, 35122.64877351296, 42549.0, 43176.784116079216, 43699.34450983174, 43954.0, 44238.336424953006, 11585.536578536765, 11686.415679216176, 11716.531338746696, 11745.47145378443, 11965.461554230254, 12271.75456490883, 12731.2997785119, 12742.362881855684, 13032.609021729364, 13188.340582971005, 11918.940405297919, 11926.642200733992, 11986.880131198577, 12401.441935113122, 12674.556390526655, 11640.533466284433, 11653.941730291293, 11696.590619328283, 11716.531338746696, 11866.288022718665, 11655.941720291345, 11862.466189021343, 11934.22427542207, 12047.638570842888, 12068.0, 9389.765255868659, 9783.41299522031, 9880.35777674449, 9970.202383809423, 10115.848262275924, 9090.863771641776, 9257.629694812133, 9405.576749046173, 9436.95281523588, 9852.408855468695], "unit": "score", "name": "yui.html", "value": 6308.803145239874}], "name": "dromaeo_css", "value": 6752.174638106448}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 111.0, 112.0, 111.0, 101.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 150.0, 174.0, 127.0, 156.0, 150.0, 128.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 164.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 120.0, 96.0, 76.0, 76.0, 77.0, 115.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 151.0, 94.0, 94.0, 94.0, 142.0, 94.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [60.0, 56.0, 54.0, 56.0, 55.0, 56.0, 57.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 82.0, 82.0, 89.0, 80.0, 82.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 128.0, 114.0, 117.0, 113.0, 124.0, 116.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [152.0, 141.0, 155.0, 146.0, 149.0, 155.0, 150.0, 151.0, 152.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1517.1999999999998}]} 13:22:32 INFO - Return code: 0 13:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:22:32 ERROR - # TBPL SUCCESS # 13:22:32 INFO - Running post-action listener: _resource_record_post_action 13:22:32 INFO - Running post-run listener: _resource_record_post_run 13:22:33 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 534540288; Read time: 0; Write time: 545168 13:22:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241025024; Read time: 0; Write time: 330528 13:22:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293515264; Read time: 0; Write time: 214640 13:22:33 INFO - Running post-run listener: _upload_blobber_files 13:22:33 INFO - Blob upload gear active. 13:22:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:22:33 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:22:33 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:22:33 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:22:34 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:34 INFO - (blobuploader) - INFO - Done attempting. 13:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:35 INFO - (blobuploader) - INFO - Done attempting. 13:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:35 INFO - Return code: 0 13:22:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78d207dacdd215c247fd380abb018c2cb5336a32932d89deb7fe9bf431ff40758c19c2689d94922baffa15675b6bf89cfe1b588d4244f2f852e274956bb3a970", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92900a99c27b6ec9a2992773f8cba029d2d3bc0764bb56be52797d6806084b8824b0431e90dedb53d14da13a6701b2ed5d6a097aa9bea2c0102ddd322e480b3c"} 13:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:22:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:22:35 INFO - Contents: 13:22:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78d207dacdd215c247fd380abb018c2cb5336a32932d89deb7fe9bf431ff40758c19c2689d94922baffa15675b6bf89cfe1b588d4244f2f852e274956bb3a970", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92900a99c27b6ec9a2992773f8cba029d2d3bc0764bb56be52797d6806084b8824b0431e90dedb53d14da13a6701b2ed5d6a097aa9bea2c0102ddd322e480b3c"} 13:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:35 INFO - Copying logs to upload dir... 13:22:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.387318 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-11 13:22:35.577403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:22:35.583421) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78d207dacdd215c247fd380abb018c2cb5336a32932d89deb7fe9bf431ff40758c19c2689d94922baffa15675b6bf89cfe1b588d4244f2f852e274956bb3a970", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92900a99c27b6ec9a2992773f8cba029d2d3bc0764bb56be52797d6806084b8824b0431e90dedb53d14da13a6701b2ed5d6a097aa9bea2c0102ddd322e480b3c"} build_url:https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011859 build_url: 'https://queue.taskcluster.net/v1/task/ZwYrZOKdQ5SdqeWdt3Ov8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78d207dacdd215c247fd380abb018c2cb5336a32932d89deb7fe9bf431ff40758c19c2689d94922baffa15675b6bf89cfe1b588d4244f2f852e274956bb3a970", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92900a99c27b6ec9a2992773f8cba029d2d3bc0764bb56be52797d6806084b8824b0431e90dedb53d14da13a6701b2ed5d6a097aa9bea2c0102ddd322e480b3c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:22:35.609101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:22:35.609426) ========= 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=00204705a9daa57ed339a427000001b9-1457729640.744866-585651980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:22:35.692851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:22:35.693190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:22:35.693510) ========= ========= Total master_lag: 0.28 =========