builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1455046135.16 results: success (0) buildid: 20160209083244 builduid: 7b00fe89e15e4288a0db4404b2b3bf5b revision: 5afb767f35912c1931481d24b31571fd8d14ac4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.158826) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.159320) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.159709) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.187377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.188103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.204124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.204610) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.266686) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.267008) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.267384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.267691) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 11:28:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-02-09 11:28:55 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127419 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.420990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.421334) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018411 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:55.479842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 11:28:55.480235) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5afb767f35912c1931481d24b31571fd8d14ac4c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5afb767f35912c1931481d24b31571fd8d14ac4c --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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 11:28:55,969 truncating revision to first 12 chars 2016-02-09 11:28:55,969 Setting DEBUG logging. 2016-02-09 11:28:55,969 attempt 1/10 2016-02-09 11:28:55,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5afb767f3591?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 11:28:56,789 unpacking tar archive at: fx-team-5afb767f3591/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 11:28:56.586842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:56.587503) ========= echo 5afb767f35912c1931481d24b31571fd8d14ac4c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5afb767f35912c1931481d24b31571fd8d14ac4c'] 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5afb767f35912c1931481d24b31571fd8d14ac4c program finished with exit code 0 elapsedTime=0.004681 script_repo_revision: '5afb767f35912c1931481d24b31571fd8d14ac4c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:56.641198) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:56.641629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 11:28:56.652464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-02-09 11:28:56.653184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:28:57 INFO - MultiFileLogger online at 20160209 11:28:57 in /builds/slave/test-pgo 11:28:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:28:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:28:57 INFO - {'append_to_log': False, 11:28:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:28:57 INFO - 'blob_upload_branch': 'Fx-Team', 11:28:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:28:57 INFO - 'branch': 'Fx-Team', 11:28:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:57 INFO - 'config_files': ('talos/linux_config.py',), 11:28:57 INFO - 'default_actions': ('clobber', 11:28:57 INFO - 'read-buildbot-config', 11:28:57 INFO - 'download-and-extract', 11:28:57 INFO - 'populate-webroot', 11:28:57 INFO - 'create-virtualenv', 11:28:57 INFO - 'install', 11:28:57 INFO - 'run-tests'), 11:28:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:57 INFO - 'download_minidump_stackwalk': True, 11:28:57 INFO - 'download_symbols': 'ondemand', 11:28:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:28:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:28:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:28:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:28:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:57 INFO - 'installer_path': 'installer.exe', 11:28:57 INFO - 'log_level': 'info', 11:28:57 INFO - 'log_name': 'talos', 11:28:57 INFO - 'log_to_console': True, 11:28:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:28:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:28:57 INFO - 'opt_config_files': (), 11:28:57 INFO - 'pip_index': False, 11:28:57 INFO - 'sps_profile': False, 11:28:57 INFO - 'sps_profile_interval': 0, 11:28:57 INFO - 'suite': 'dromaeojs', 11:28:57 INFO - 'system_bits': '32', 11:28:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:57 INFO - 'title': 'talos-linux64-ix-029', 11:28:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:57 INFO - 'use_talos_json': True, 11:28:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:28:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:57 INFO - 'work_dir': 'build'} 11:28:57 INFO - ##### 11:28:57 INFO - ##### Running clobber step. 11:28:57 INFO - ##### 11:28:57 INFO - Running pre-action listener: _resource_record_pre_action 11:28:57 INFO - Running main action method: clobber 11:28:57 INFO - rmtree: /builds/slave/test-pgo/build 11:28:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:28:57 INFO - Running post-action listener: _resource_record_post_action 11:28:57 INFO - ##### 11:28:57 INFO - ##### Running read-buildbot-config step. 11:28:57 INFO - ##### 11:28:57 INFO - Running pre-action listener: _resource_record_pre_action 11:28:57 INFO - Running main action method: read_buildbot_config 11:28:57 INFO - Using buildbot properties: 11:28:57 INFO - { 11:28:57 INFO - "project": "", 11:28:57 INFO - "product": "firefox", 11:28:57 INFO - "script_repo_revision": "production", 11:28:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:28:57 INFO - "repository": "", 11:28:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:28:57 INFO - "buildid": "20160209083244", 11:28:57 INFO - "pgo_build": "True", 11:28:57 INFO - "basedir": "/builds/slave/test-pgo", 11:28:57 INFO - "buildnumber": 482, 11:28:57 INFO - "slavename": "talos-linux64-ix-029", 11:28:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:28:57 INFO - "platform": "ubuntu64_hw", 11:28:57 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:28:57 INFO - "branch": "fx-team", 11:28:57 INFO - "repo_path": "integration/fx-team", 11:28:57 INFO - "revision": "5afb767f35912c1931481d24b31571fd8d14ac4c", 11:28:57 INFO - "stage_platform": "linux64-pgo", 11:28:57 INFO - "builduid": "7b00fe89e15e4288a0db4404b2b3bf5b", 11:28:57 INFO - "slavebuilddir": "test" 11:28:57 INFO - } 11:28:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:28:57 INFO - Running post-action listener: _resource_record_post_action 11:28:57 INFO - ##### 11:28:57 INFO - ##### Running download-and-extract step. 11:28:57 INFO - ##### 11:28:57 INFO - Running pre-action listener: _resource_record_pre_action 11:28:57 INFO - Running main action method: download_and_extract 11:28:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:28: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')]} 11:28:57 INFO - https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/test_packages.json 11:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/test_packages.json 11:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:29:05 INFO - Downloaded 1448 bytes. 11:29:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:29:05 INFO - Using the following test package requirements: 11:29:05 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:29:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:29:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:29:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'jsshell-linux-x86_64.zip'], 11:29:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:29:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:29:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:29:05 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:29:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:29:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:29:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:29:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:29:05 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')]} 11:29:05 INFO - https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:29:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:29:20 INFO - Downloaded 23289756 bytes. 11:29:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:29:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:29:21 INFO - Return code: 0 11:29:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:21 INFO - https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:29:24 INFO - Downloaded 23289756 bytes. 11:29:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:29:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:29:25 INFO - Return code: 0 11:29: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')]} 11:29:25 INFO - https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:29:57 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 11:29:57 INFO - retry: attempt #1 caught exception: The read operation timed out 11:29:57 INFO - retry: Failed, sleeping 30 seconds before retrying 11:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 11:30:28 INFO - Downloaded 10706547 bytes. 11:30:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:30:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:30:28 INFO - Return code: 0 11:30: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')]} 11:30:28 INFO - https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:30:29 INFO - Downloaded 56533670 bytes. 11:30:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:29 INFO - mkdir: /builds/slave/test-pgo/properties 11:30:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:30:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:30:29 INFO - Contents: 11:30:29 INFO - build_url:https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:30 INFO - Running post-action listener: _resource_record_post_action 11:30:30 INFO - Running post-action listener: set_extra_try_arguments 11:30:30 INFO - ##### 11:30:30 INFO - ##### Running populate-webroot step. 11:30:30 INFO - ##### 11:30:30 INFO - Running pre-action listener: _resource_record_pre_action 11:30:30 INFO - Running main action method: populate_webroot 11:30:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:30 INFO - '--tppagecycles', 11:30:30 INFO - '7'], 11:30:30 INFO - 'tests': ['tsvgm']}}, 11:30:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:30:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:30:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'tests': ['damp', 'tps']}, 11:30:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['damp', 'tps']}, 11:30:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:30:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:30 INFO - 'other': {'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'other_l64': {'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'other_nol64': {'tests': ['a11yr', 11:30:30 INFO - 'ts_paint', 11:30:30 INFO - 'tpaint', 11:30:30 INFO - 'sessionrestore', 11:30:30 INFO - 'sessionrestore_no_auto_restore']}, 11:30:30 INFO - 'svgr': {'tests': ['tsvgx', 11:30:30 INFO - 'tsvgr_opacity', 11:30:30 INFO - 'tart', 11:30:30 INFO - 'tscrollx', 11:30:30 INFO - 'cart']}, 11:30:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['tsvgx', 11:30:30 INFO - 'tsvgr_opacity', 11:30:30 INFO - 'tart', 11:30:30 INFO - 'tscrollx', 11:30:30 INFO - 'cart']}, 11:30:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'tests': ['tp5o']}, 11:30:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'talos_options': ['--e10s'], 11:30:30 INFO - 'tests': ['tp5o']}, 11:30:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'talos_options': ['--xperf_path', 11:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:30 INFO - 'tests': ['tp5n']}, 11:30:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:30 INFO - 'talos_options': ['--e10s', 11:30:30 INFO - '--xperf_path', 11:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:30 INFO - 'tests': ['tp5n']}}, 11:30:30 INFO - 'talos.zip': {'path': '', 11:30:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:30 INFO - Running post-action listener: _resource_record_post_action 11:30:30 INFO - ##### 11:30:30 INFO - ##### Running create-virtualenv step. 11:30:30 INFO - ##### 11:30:30 INFO - Running pre-action listener: _resource_record_pre_action 11:30:30 INFO - Running main action method: create_virtualenv 11:30:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:30:30 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 11:30:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:30:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:30 INFO - Using real prefix '/usr' 11:30:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:30:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:33 INFO - Installing pip.................done. 11:30:33 INFO - Return code: 0 11:30:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:30:33 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')]} 11:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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')]} 11:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:33 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 11:30:33 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 11:30:33 INFO - Using env: {'DISPLAY': ':0', 11:30:33 INFO - 'HOME': '/home/cltbld', 11:30:33 INFO - 'LANG': 'en_US.UTF-8', 11:30:33 INFO - 'LANGUAGE': 'en_US:en', 11:30:33 INFO - 'LOGNAME': 'cltbld', 11:30:33 INFO - 'MAIL': '/var/mail/cltbld', 11:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:33 INFO - 'MOZ_NO_REMOTE': '1', 11:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:33 INFO - 'NO_EM_RESTART': '1', 11:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:33 INFO - 'SHELL': '/bin/bash', 11:30:33 INFO - 'SHLVL': '1', 11:30:33 INFO - 'TERM': 'linux', 11:30:33 INFO - 'TMOUT': '86400', 11:30:33 INFO - 'USER': 'cltbld', 11:30:33 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:33 INFO - '_': '/tools/buildbot/bin/python'} 11:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:33 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 11:30:33 INFO - Cleaning up... 11:30:33 INFO - Return code: 0 11:30:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:30:33 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')]} 11:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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')]} 11:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:33 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 11:30:33 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 11:30:33 INFO - Using env: {'DISPLAY': ':0', 11:30:33 INFO - 'HOME': '/home/cltbld', 11:30:33 INFO - 'LANG': 'en_US.UTF-8', 11:30:33 INFO - 'LANGUAGE': 'en_US:en', 11:30:33 INFO - 'LOGNAME': 'cltbld', 11:30:33 INFO - 'MAIL': '/var/mail/cltbld', 11:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:33 INFO - 'MOZ_NO_REMOTE': '1', 11:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:33 INFO - 'NO_EM_RESTART': '1', 11:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:33 INFO - 'SHELL': '/bin/bash', 11:30:33 INFO - 'SHLVL': '1', 11:30:33 INFO - 'TERM': 'linux', 11:30:33 INFO - 'TMOUT': '86400', 11:30:33 INFO - 'USER': 'cltbld', 11:30:33 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:33 INFO - '_': '/tools/buildbot/bin/python'} 11:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:33 INFO - Downloading/unpacking psutil>=0.7.1 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:35 INFO - Installing collected packages: psutil 11:30:35 INFO - Running setup.py install for psutil 11:30:35 INFO - building 'psutil._psutil_linux' extension 11:30:35 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 11:30:35 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 11:30:35 INFO - building 'psutil._psutil_posix' extension 11:30:35 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 11:30:35 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 11:30:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:35 INFO - Successfully installed psutil 11:30:35 INFO - Cleaning up... 11:30:35 INFO - Return code: 0 11:30:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:30: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')]} 11:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', '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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:30: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 mozsystemmonitor==0.0.0 11:30:36 INFO - Using env: {'DISPLAY': ':0', 11:30:36 INFO - 'HOME': '/home/cltbld', 11:30:36 INFO - 'LANG': 'en_US.UTF-8', 11:30:36 INFO - 'LANGUAGE': 'en_US:en', 11:30:36 INFO - 'LOGNAME': 'cltbld', 11:30:36 INFO - 'MAIL': '/var/mail/cltbld', 11:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:36 INFO - 'MOZ_NO_REMOTE': '1', 11:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:36 INFO - 'NO_EM_RESTART': '1', 11:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:36 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:36 INFO - 'SHELL': '/bin/bash', 11:30:36 INFO - 'SHLVL': '1', 11:30:36 INFO - 'TERM': 'linux', 11:30:36 INFO - 'TMOUT': '86400', 11:30:36 INFO - 'USER': 'cltbld', 11:30:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:36 INFO - '_': '/tools/buildbot/bin/python'} 11:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:30:36 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 11:30:36 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 11:30:36 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 11:30:36 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 11:30:36 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 11:30:36 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 11:30:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:30:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:30:38 INFO - Installing collected packages: mozsystemmonitor 11:30:38 INFO - Running setup.py install for mozsystemmonitor 11:30:38 INFO - Successfully installed mozsystemmonitor 11:30:38 INFO - Cleaning up... 11:30:38 INFO - Return code: 0 11:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:30: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')]} 11:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', '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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:30: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 blobuploader==1.2.4 11:30:38 INFO - Using env: {'DISPLAY': ':0', 11:30:38 INFO - 'HOME': '/home/cltbld', 11:30:38 INFO - 'LANG': 'en_US.UTF-8', 11:30:38 INFO - 'LANGUAGE': 'en_US:en', 11:30:38 INFO - 'LOGNAME': 'cltbld', 11:30:38 INFO - 'MAIL': '/var/mail/cltbld', 11:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:38 INFO - 'MOZ_NO_REMOTE': '1', 11:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:38 INFO - 'NO_EM_RESTART': '1', 11:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:38 INFO - 'SHELL': '/bin/bash', 11:30:38 INFO - 'SHLVL': '1', 11:30:38 INFO - 'TERM': 'linux', 11:30:38 INFO - 'TMOUT': '86400', 11:30:38 INFO - 'USER': 'cltbld', 11:30:38 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:38 INFO - '_': '/tools/buildbot/bin/python'} 11:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:30:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30: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 11:30:40 INFO - Downloading docopt-0.6.1.tar.gz 11:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:40 INFO - Running setup.py install for blobuploader 11:30:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:30:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:30:41 INFO - Running setup.py install for requests 11:30:41 INFO - Running setup.py install for docopt 11:30:41 INFO - Successfully installed blobuploader requests docopt 11:30:41 INFO - Cleaning up... 11:30:41 INFO - Return code: 0 11:30:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:41 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:41 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 11:30:41 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 11:30:41 INFO - Using env: {'DISPLAY': ':0', 11:30:41 INFO - 'HOME': '/home/cltbld', 11:30:41 INFO - 'LANG': 'en_US.UTF-8', 11:30:41 INFO - 'LANGUAGE': 'en_US:en', 11:30:41 INFO - 'LOGNAME': 'cltbld', 11:30:41 INFO - 'MAIL': '/var/mail/cltbld', 11:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:41 INFO - 'MOZ_NO_REMOTE': '1', 11:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:41 INFO - 'NO_EM_RESTART': '1', 11:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:41 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:41 INFO - 'SHELL': '/bin/bash', 11:30:41 INFO - 'SHLVL': '1', 11:30:41 INFO - 'TERM': 'linux', 11:30:41 INFO - 'TMOUT': '86400', 11:30:41 INFO - 'USER': 'cltbld', 11:30:41 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:41 INFO - '_': '/tools/buildbot/bin/python'} 11:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:41 INFO - Running setup.py (path:/tmp/pip-HU7YFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:41 INFO - Running setup.py (path:/tmp/pip-Voxs7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:41 INFO - Running setup.py (path:/tmp/pip-oMWt7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:41 INFO - Running setup.py (path:/tmp/pip-6IZ3eH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:42 INFO - Running setup.py (path:/tmp/pip-AqsbJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:42 INFO - Running setup.py (path:/tmp/pip-FlQxE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:42 INFO - Running setup.py (path:/tmp/pip-WfhMkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:42 INFO - Running setup.py (path:/tmp/pip-4ZI8qG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:42 INFO - Running setup.py (path:/tmp/pip-4lQpgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:42 INFO - Running setup.py (path:/tmp/pip-_xug9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:42 INFO - Running setup.py (path:/tmp/pip-PYnsV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:42 INFO - Running setup.py (path:/tmp/pip-Qi8Jtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:42 INFO - Running setup.py (path:/tmp/pip-FGGyzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:42 INFO - Running setup.py (path:/tmp/pip-hwvwtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:42 INFO - Running setup.py (path:/tmp/pip-SJRVoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:42 INFO - Running setup.py (path:/tmp/pip-Z2k1iR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:42 INFO - Running setup.py (path:/tmp/pip-cEe1tC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:42 INFO - Running setup.py install for manifestparser 11:30:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for mozcrash 11:30:43 INFO - Running setup.py install for mozdebug 11:30:43 INFO - Running setup.py install for mozdevice 11:30:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for mozfile 11:30:43 INFO - Running setup.py install for mozhttpd 11:30:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for mozinfo 11:30:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for mozInstall 11:30:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for mozleak 11:30:43 INFO - Running setup.py install for mozlog 11:30:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:30:43 INFO - Running setup.py install for moznetwork 11:30:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Running setup.py install for mozprocess 11:30:44 INFO - Running setup.py install for mozprofile 11:30:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Running setup.py install for mozrunner 11:30:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Running setup.py install for mozscreenshot 11:30:44 INFO - Running setup.py install for moztest 11:30:44 INFO - Running setup.py install for mozversion 11:30:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:30:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:44 INFO - Cleaning up... 11:30:44 INFO - Return code: 0 11:30:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:44 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:44 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 11:30:44 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 11:30:44 INFO - Using env: {'DISPLAY': ':0', 11:30:44 INFO - 'HOME': '/home/cltbld', 11:30:44 INFO - 'LANG': 'en_US.UTF-8', 11:30:44 INFO - 'LANGUAGE': 'en_US:en', 11:30:44 INFO - 'LOGNAME': 'cltbld', 11:30:44 INFO - 'MAIL': '/var/mail/cltbld', 11:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:44 INFO - 'MOZ_NO_REMOTE': '1', 11:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:44 INFO - 'NO_EM_RESTART': '1', 11:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:44 INFO - 'SHELL': '/bin/bash', 11:30:44 INFO - 'SHLVL': '1', 11:30:44 INFO - 'TERM': 'linux', 11:30:44 INFO - 'TMOUT': '86400', 11:30:44 INFO - 'USER': 'cltbld', 11:30:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:44 INFO - '_': '/tools/buildbot/bin/python'} 11:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:44 INFO - Running setup.py (path:/tmp/pip-gjlZTZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:45 INFO - Running setup.py (path:/tmp/pip-8ha4t9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:45 INFO - Running setup.py (path:/tmp/pip-tcfYKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:45 INFO - Running setup.py (path:/tmp/pip-v5XsIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:45 INFO - Running setup.py (path:/tmp/pip-kTi0bu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:45 INFO - Running setup.py (path:/tmp/pip-7NiG9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:45 INFO - Running setup.py (path:/tmp/pip-9FKttE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:45 INFO - Running setup.py (path:/tmp/pip-ajKdBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:45 INFO - Running setup.py (path:/tmp/pip-8bbtIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:45 INFO - Running setup.py (path:/tmp/pip-nJiSDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:45 INFO - Running setup.py (path:/tmp/pip-9GGJWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:45 INFO - Running setup.py (path:/tmp/pip-oPHbrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:45 INFO - Running setup.py (path:/tmp/pip-bb1vap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:45 INFO - Running setup.py (path:/tmp/pip-EiXqxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:45 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)) 11:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:45 INFO - Running setup.py (path:/tmp/pip-X3CMRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:46 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)) 11:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:46 INFO - Running setup.py (path:/tmp/pip-F0xaHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:46 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)) 11:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:46 INFO - Running setup.py (path:/tmp/pip-UeBP5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:46 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)) 11:30:46 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:30:46 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:30:46 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)) 11:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:30:46 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)) 11:30:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:47 INFO - Downloading blessings-1.6.tar.gz 11:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:30:48 INFO - Installing collected packages: blessings 11:30:48 INFO - Running setup.py install for blessings 11:30:48 INFO - Successfully installed blessings 11:30:48 INFO - Cleaning up... 11:30:48 INFO - Return code: 0 11:30:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:30:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:30:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:30:48 INFO - Reading from file tmpfile_stdout 11:30:48 INFO - Current package versions: 11:30:48 INFO - argparse == 1.2.1 11:30:48 INFO - blessings == 1.6 11:30:48 INFO - blobuploader == 1.2.4 11:30:48 INFO - docopt == 0.6.1 11:30:48 INFO - manifestparser == 1.1 11:30:48 INFO - mozInstall == 1.12 11:30:48 INFO - mozcrash == 0.16 11:30:48 INFO - mozdebug == 0.1 11:30:48 INFO - mozdevice == 0.48 11:30:48 INFO - mozfile == 1.2 11:30:48 INFO - mozhttpd == 0.7 11:30:48 INFO - mozinfo == 0.9 11:30:48 INFO - mozleak == 0.1 11:30:48 INFO - mozlog == 3.1 11:30:48 INFO - moznetwork == 0.27 11:30:48 INFO - mozprocess == 0.22 11:30:48 INFO - mozprofile == 0.28 11:30:48 INFO - mozrunner == 6.11 11:30:48 INFO - mozscreenshot == 0.1 11:30:48 INFO - mozsystemmonitor == 0.0 11:30:48 INFO - moztest == 0.7 11:30:48 INFO - mozversion == 1.4 11:30:48 INFO - psutil == 3.1.1 11:30:48 INFO - requests == 1.2.3 11:30:48 INFO - wsgiref == 0.1.2 11:30:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:48 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')]} 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:48 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')]} 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:48 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:48 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 11:30:48 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 11:30:48 INFO - Using env: {'DISPLAY': ':0', 11:30:48 INFO - 'HOME': '/home/cltbld', 11:30:48 INFO - 'LANG': 'en_US.UTF-8', 11:30:48 INFO - 'LANGUAGE': 'en_US:en', 11:30:48 INFO - 'LOGNAME': 'cltbld', 11:30:48 INFO - 'MAIL': '/var/mail/cltbld', 11:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:48 INFO - 'MOZ_NO_REMOTE': '1', 11:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:48 INFO - 'NO_EM_RESTART': '1', 11:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:48 INFO - 'SHELL': '/bin/bash', 11:30:48 INFO - 'SHLVL': '1', 11:30:48 INFO - 'TERM': 'linux', 11:30:48 INFO - 'TMOUT': '86400', 11:30:48 INFO - 'USER': 'cltbld', 11:30:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:48 INFO - '_': '/tools/buildbot/bin/python'} 11:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 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)) 11:30:48 INFO - Cleaning up... 11:30:48 INFO - Return code: 0 11:30:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:30:48 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')]} 11:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:48 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')]} 11:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:48 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:48 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 11:30:48 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 11:30:48 INFO - Using env: {'DISPLAY': ':0', 11:30:48 INFO - 'HOME': '/home/cltbld', 11:30:48 INFO - 'LANG': 'en_US.UTF-8', 11:30:48 INFO - 'LANGUAGE': 'en_US:en', 11:30:48 INFO - 'LOGNAME': 'cltbld', 11:30:48 INFO - 'MAIL': '/var/mail/cltbld', 11:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:48 INFO - 'MOZ_NO_REMOTE': '1', 11:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:48 INFO - 'NO_EM_RESTART': '1', 11:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:48 INFO - 'SHELL': '/bin/bash', 11:30:48 INFO - 'SHLVL': '1', 11:30:48 INFO - 'TERM': 'linux', 11:30:48 INFO - 'TMOUT': '86400', 11:30:48 INFO - 'USER': 'cltbld', 11:30:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:48 INFO - '_': '/tools/buildbot/bin/python'} 11:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:48 INFO - Downloading/unpacking jsonschema 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:50 INFO - Downloading/unpacking functools32 (from jsonschema) 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:50 INFO - warning: no files found matching '*.txt' 11:30:50 INFO - no previously-included directories found matching 'build' 11:30:50 INFO - no previously-included directories found matching 'dist' 11:30:50 INFO - no previously-included directories found matching '.git*' 11:30:50 INFO - Installing collected packages: jsonschema, functools32 11:30:50 INFO - Running setup.py install for functools32 11:30:51 INFO - warning: no files found matching '*.txt' 11:30:51 INFO - no previously-included directories found matching 'build' 11:30:51 INFO - no previously-included directories found matching 'dist' 11:30:51 INFO - no previously-included directories found matching '.git*' 11:30:51 INFO - Successfully installed jsonschema functools32 11:30:51 INFO - Cleaning up... 11:30:51 INFO - Return code: 0 11:30:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:30:51 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')]} 11:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:51 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')]} 11:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:51 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 0x7f99cd790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, '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': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', '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 11:30:51 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 11:30:51 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 11:30:51 INFO - Using env: {'DISPLAY': ':0', 11:30:51 INFO - 'HOME': '/home/cltbld', 11:30:51 INFO - 'LANG': 'en_US.UTF-8', 11:30:51 INFO - 'LANGUAGE': 'en_US:en', 11:30:51 INFO - 'LOGNAME': 'cltbld', 11:30:51 INFO - 'MAIL': '/var/mail/cltbld', 11:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:51 INFO - 'MOZ_NO_REMOTE': '1', 11:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:51 INFO - 'NO_EM_RESTART': '1', 11:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:51 INFO - 'SHELL': '/bin/bash', 11:30:51 INFO - 'SHLVL': '1', 11:30:51 INFO - 'TERM': 'linux', 11:30:51 INFO - 'TMOUT': '86400', 11:30:51 INFO - 'USER': 'cltbld', 11:30:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:51 INFO - '_': '/tools/buildbot/bin/python'} 11:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:51 INFO - Downloading/unpacking flake8 11:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:30:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:30:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:53 INFO - no previously-included directories found matching 'docs/_build' 11:30:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:30:53 INFO - Running setup.py install for pep8 11:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:53 INFO - no previously-included directories found matching 'docs/_build' 11:30:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:30:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:30:53 INFO - Cleaning up... 11:30:53 INFO - Return code: 0 11:30:53 INFO - Running post-action listener: _resource_record_post_action 11:30:53 INFO - Running post-action listener: _start_resource_monitoring 11:30:54 INFO - Starting resource monitoring. 11:30:54 INFO - ##### 11:30:54 INFO - ##### Running install step. 11:30:54 INFO - ##### 11:30:54 INFO - Running pre-action listener: _resource_record_pre_action 11:30:54 INFO - Running main action method: install 11:30:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:30:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:30:54 INFO - Reading from file tmpfile_stdout 11:30:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:30:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:30:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:30:54 INFO - Reading from file tmpfile_stdout 11:30:54 INFO - Output received: 11:30:54 INFO - Usage: mozinstall [options] installer 11:30:54 INFO - Options: 11:30:54 INFO - -h, --help show this help message and exit 11:30:54 INFO - -d DEST, --destination=DEST 11:30:54 INFO - Directory to install application into. [default: 11:30:54 INFO - "/builds/slave/test-pgo"] 11:30:54 INFO - --app=APP Application being installed. [default: firefox] 11:30:54 INFO - mkdir: /builds/slave/test-pgo/build/application 11:30:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:30:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:31:10 INFO - Reading from file tmpfile_stdout 11:31:10 INFO - Output received: 11:31:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:31:10 INFO - Running post-action listener: _resource_record_post_action 11:31:10 INFO - ##### 11:31:10 INFO - ##### Running run-tests step. 11:31:10 INFO - ##### 11:31:10 INFO - Running pre-action listener: _resource_record_pre_action 11:31:10 INFO - Running main action method: run_tests 11:31:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:31:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:31:10 INFO - Python 2.7.3 11:31:10 INFO - Return code: 0 11:31:10 INFO - grabbing minidump binary from tooltool 11:31:10 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')]} 11:31:10 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 0x20ae8c0>, '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 0x20af7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20afc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:31:10 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 11:31:10 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 11:31:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:10 INFO - Return code: 0 11:31:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:31:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:31:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:31:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:31:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:31:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:31:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:31:11 INFO - Return code: 0 11:31:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 11:31:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 11:31:11 INFO - Using env: {'DISPLAY': ':0', 11:31:11 INFO - 'HOME': '/home/cltbld', 11:31:11 INFO - 'LANG': 'en_US.UTF-8', 11:31:11 INFO - 'LANGUAGE': 'en_US:en', 11:31:11 INFO - 'LOGNAME': 'cltbld', 11:31:11 INFO - 'MAIL': '/var/mail/cltbld', 11:31:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:31:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:11 INFO - 'MOZ_NO_REMOTE': '1', 11:31:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:11 INFO - 'NO_EM_RESTART': '1', 11:31:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:31:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:31:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:31:11 INFO - 'SHELL': '/bin/bash', 11:31:11 INFO - 'SHLVL': '1', 11:31:11 INFO - 'TERM': 'linux', 11:31:11 INFO - 'TMOUT': '86400', 11:31:11 INFO - 'USER': 'cltbld', 11:31:11 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587', 11:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:11 INFO - '_': '/tools/buildbot/bin/python'} 11:31:11 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 11:31:11 INFO - mozversion application_buildid: 20160209083244 11:31:11 INFO - mozversion application_changeset: 5afb767f35912c1931481d24b31571fd8d14ac4c 11:31:11 INFO - mozversion application_display_name: Nightly 11:31:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:11 INFO - mozversion application_name: Firefox 11:31:11 INFO - mozversion application_remotingname: firefox 11:31:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:31:11 INFO - mozversion application_vendor: Mozilla 11:31:11 INFO - mozversion application_version: 47.0a1 11:31:11 INFO - mozversion platform_buildid: 20160209083244 11:31:11 INFO - mozversion platform_changeset: 5afb767f35912c1931481d24b31571fd8d14ac4c 11:31:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:31:11 INFO - mozversion platform_version: 47.0a1 11:31:11 INFO - using testdate: 1455046271 11:31:11 INFO - actual date: 1455046271 11:31:11 INFO - starting webserver on 'localhost:58364' 11:31:11 INFO - SUITE-START | Running 2 tests 11:31:11 INFO - TEST-START | dromaeo_css 11:31:11 INFO - operating with platform_type : linux_ 11:31:11 INFO - Initialising browser for dromaeo_css test... 11:31:11 INFO - TEST-INFO | started process 22470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcYQmh4/profile http://localhost:58364/getInfo.html) 11:31:15 INFO - PROCESS | 22470 | __metrics Screen width/height:1600/1200 11:31:15 INFO - PROCESS | 22470 | colorDepth:24 11:31:15 INFO - PROCESS | 22470 | Browser inner width/height: 1024/697 11:31:15 INFO - PROCESS | 22470 | __metrics 11:31:15 INFO - PROCESS | 22470 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:16 INFO - TEST-INFO | 22470: exit 0 11:31:16 INFO - Browser initialized. 11:31:16 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:16 INFO - TEST-INFO | started process 22563 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcYQmh4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:28 INFO - PROCESS | 22563 | RSS: Main: 152670208 11:31:28 INFO - PROCESS | 22563 | 11:32:19 INFO - PROCESS | 22563 | 1455046339283 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] 11:34:27 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58364/tests/dromaeo/cssquery-ext.html) 11:34:28 INFO - PROCESS | 22563 | RSS: Main: 252387328 11:34:28 INFO - PROCESS | 22563 | 11:37:30 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-ext.html (next: http://localhost:58364/tests/dromaeo/cssquery-jquery.html) 11:37:31 INFO - PROCESS | 22563 | RSS: Main: 230682624 11:37:31 INFO - PROCESS | 22563 | 11:40:33 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58364/tests/dromaeo/cssquery-mootools.html) 11:40:34 INFO - PROCESS | 22563 | RSS: Main: 234532864 11:40:34 INFO - PROCESS | 22563 | 11:43:36 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58364/tests/dromaeo/cssquery-prototype.html) 11:43:36 INFO - PROCESS | 22563 | RSS: Main: 217993216 11:43:36 INFO - PROCESS | 22563 | 11:46:39 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58364/tests/dromaeo/cssquery-yui.html) 11:46:39 INFO - PROCESS | 22563 | RSS: Main: 219025408 11:46:39 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | Cycle 1(1): loaded http://localhost:58364/tests/dromaeo/cssquery-yui.html (next: http://localhost:58364/tests/dromaeo/cssquery-dojo.html) 11:49:42 INFO - PROCESS | 22563 | RSS: Main: 301060096 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | __start_tp_report 11:49:42 INFO - PROCESS | 22563 | _x_x_mozilla_page_load 11:49:42 INFO - PROCESS | 22563 | _x_x_mozilla_page_load_details 11:49:42 INFO - PROCESS | 22563 | |i|pagename|runs| 11:49:42 INFO - PROCESS | 22563 | |0;dojo.html;3137.435261652902;3205.903822885314;3254.1701866024146;3255.658155893631;3271.86912523499;5185.274061631375;5203.53168214861;5230.633855630107;5256.474352564746;5291.523762861341;5215.86960325992;5222.608304377178;5274;5276.947230527693;5313.601479889005;4786.353842231289;4811.374521312225;4816.060868130716;4841.782119804618;4917.655764096515;534.2898927106205;4758.833440829571;4838.927416088762;4894.045661096087;4894.926576101361;4751.714897106167;4815.735134567597;4852.417709874838;4863.537963893442;4896;4788.545088216614;4804.5195480451675;4804.687695299829;4811.879703007417;4851.175300198939;4748.264019077049;4785.521447855222;4816.879578010543;4821.132196204681;4851.757412129415;5125.846224613268;5148.047611191904;5180.093483640386;5192.402873669501;5219.4780521947505;5568.109102543614;5574.944250557483;5580.91628625571;5582.581306402036;5591.3569939457075;5554.305711786027;5557.805476808333;5635.746391412396;5638.069718496443;5649.350324712669;5284.682919024871;5293.761780719877;5295.258663787073;5311.256424100629;5345.251664766897;5741.7990370337675;5759.337676167211;5765.538756899438;5782.2483077199695;5782.392848750821;5518.392976772552;5545.500904918576;5546.195801608825;5559.499645031967;5577.470140336662;5703.17303990919;5706.457886500859;5708.343540492813;5708.942910570924;5713.800016999385;5645.322561292671;5648.8870222595315;5683.403242659544;5686.687232202185;5691.430856914359;5593.608447408642;5641.210230567724;5656.038473459522;5678.687672177987;5760.164776107441;4363.694541382136;4365.017870979004;4373.037931655031;4377.649788016951;4406.7576283304725;3911.843526258918;3913.5695073541888;3916.4321173429694;3949.071968087497;3964.4647972523917;5171.172612382001;5236.633435659467;5245.0558899398475;5295.073362161684;5332.3867755207875;5643.294588176478;5647.29408823897;5655.4910058094965;5671.971640141773;5676.063449530781;5190.351206099238;5251.396089449686;5254.579633629301;5262.736863156827;5305.681659100389;4786.234202527578;4800.903981920412;4825.276208568673;4834.299026641117;4868.9756551217015;5881.441263080001;5886.087656413263;5891.1457838614015;5901.9999999999145;5909.379515150933;5514.228008078792;5659.151127330769;5661.927644847346;5675.801346952837;5707.486326230659;5840.2991641003355;5874.941250587611;5896.852578685567;5907.70461476933;5910.261217347832;5558.944410556004;5564.19319198722;5575.498205161555;5581.49766521015;5599.272094627672;5561.360443549043;5629.577781666473;5647.181158731879;5653.943460565506;5657.830265092054;5545.417731138334;5582.246396736388;5588.245586845724;5590.7763689453595;5615.326160860723;5540.168974653834;5552.222688823487;5563.276774019351;5568.888622227451;5578.246936663499;5358.062339090566;5428.891422171613;5462.235287059894;5512.173174023928;5515.283013208257;5530.557555395479;5535.225068490495;5543.584231182596;5544.112941929272;5584.581156413204;5410.540104091039;5413.323334583177;5417.593680474059;5419.6206265562605;5434.701091440009 11:49:42 INFO - PROCESS | 22563 | |1;ext.html;497.5372903200022;525.0313172197294;533.6131304804018;538.0395993152224;549.9340079190497;28011.579826302623;28865.13404597863;36575.81712091439;37046.8147659262;37152.25695486089;39950;40524;40524.189516209655;40563.39154912678;40591;7428.9257107428775;7488.513246638951;8459.11179326171;8668.349873759462;8668.60991255395;10312;10576.10103141234;10602.522886470128;10613.73465663357;10618.097461715763;10304.38173709576;10399.948000259988;10401.84397234042;10420.270581059329;10421.062104410601;10198.592056317775;10274.178065754797;10288.53701583423;10305.793884122275;10308.123809476203;10108.797824043551;10295.742606434824;10296.536655850505;10598;10601.681949541526;40048.799756001325;40376.79811600952;40378.394324085166;40474.797626011976;40522;3206.3266713990092;3324.900252992414;3403.5745531808525;3646.9452958205648;3878.049877779934;29647.851760741272;29879.850600747075;30689.079327620206;31200.531992020136;31396;3923.4899463069905;3984.820683069269;4024.2756303865294;4074.490688663917;4086.8160932758096;256576;259502;260613;260899;261315;51470.22794658008;58488;58891.41108588945;58977;59384.10923836146;53068.20397694038;53617.46382536203;53697;53918;53957.730211348695;15780.447684331222;15937.20313984296;15947.681046379008;15972.920135399481;15974.840251597569;12360.320182389874;12429.37853107341;12430.502779888704;12439.564615238423;12483.438245278985;18776.624467510574;18950.147243373805;19553;19555.51111222231;19668.70496942547;7828.608569571498;7932.365410767125;8018.639161237758;8040.718574849852;8062;988.8566157907063;1096.0902450965839;1102.8841971593029;1112.844201811747;1210.9818352724717;29003;29208;29693.554596681068;30249.546256806167;30316.54525182124;1071.4321409652896;1095.611058074388;1096.270979798425;1101.801675698382;1130.1862658885589;15911.443099491462;16088.436904708278;16309.42916997923;16331.755023674654;16586.253618587194;291942;296092;296727;296759;297227;52677.209841852404;52786.47213527892;52882.206766898526;52899.206511902354;53052.73473632607;1369.0621923982103;1372.8627137286392;1381.4198036824357;1390.1242217403174;1398.3916996106725;29462;30270.84864575663;30347.393052139276;30655.54016689796;30888.691113088582;41740.582594174884;41772.79113604534;41995;42003.57996419997;42066.15867682568;264854;282806;283420;285507;286184;30114.84942575273;30620.387592248477;30692.539611906286;30988.380232395677;31032.53451198189;35635.46546801852;36326.27347453089;36371.81814090913;37012.259754805295;37103.62896371002;32513.67486325201;33076.503852441754;33394.4990825133;33702.662973370934;38239.80880095582;28239.717602823708;32158.839205803823;33816.60854707695;33976;35975.92072237837;33112;33737.325253495284;34004.82997584996;34014.65985340115;34105;29172.854135729187;31452;31867.681323186473;31986.52020219652;32056.35887282288;24427;24737.752622474265;24806.131785387424;25081.749182508673;25110.49779004446 11:49:42 INFO - PROCESS | 22563 | |2;jquery.html;370.07481296758107;370.7312198655975;372.1589208389042;373.42119714442606;377.4470400862739;14033.578992630237;14119;16515.83484165158;17255.309787608498;17909.10454477274;16363;16491.422800201995;16804.15979201041;16833;16891.493255202364;3841.654251117399;4900.705957642535;5130;5137.126688462951;5138.152204886189;5169.276301317818;5426.75579598917;5432.83701488954;5433.239346491494;5436.700981446019;5252.553532949704;5332.960072785809;5373.489518495756;5397.217403476494;5404.1083221268445;5149.665271757323;5353.892922141555;5356.839294821161;5369.919451208235;5371.248025276464;5349.411564727877;5362.222477740745;5365.704886231256;5365.704886231256;5366.70483123428;12385.442655080544;12927.030472714585;12931.806022909665;12933.611991640266;20047.398578042536;2070.440980935139;2183.9844472320287;2307.6884620576175;2558.8740953980373;2746.615473833665;9306.441613503212;9657.130858222723;9869.062439068277;10020.248481363855;12086.33525156116;1718.183862665224;1786.6783978883795;1837.5406148462885;1916.0611300462813;1967.3704414587337;56867;62481.68759156221;63739.999999999534;64097.79511024477;64142.679286603736;10103.696889093191;10211.7447063824;10215.489225538693;10334.276600638033;10386.324888882198;12841.101122921305;13583.185008899498;13593.388297526635;13636.386362613706;13645.727085458433;7355.742549010866;7388.889166662504;7415.295546923034;7647.770566883002;7725.768226953201;6980.092587963532;7009.264027277164;7021.473389495706;7661.42539309554;7720.3051725344985;4147.460830092129;4298.161858437575;4319.848805291863;4438.6005259526155;4486.12520558488;1765.540959350578;1804.3143605429852;1846.1230915315118;1849.4359220437627;1863.2453856188265;937.6436953957452;961.2886464016577;963.1139351796364;1003.9498025098716;1037.8391349340864;15791.842081579267;16131.274092665859;16199.676006479804;16832.410865619644;17089;977.6382738386842;978.2711879649564;1011.6509804117568;1021.5403068619152;1031.4275577054657;9491.810163796685;9590.280728945358;9710.17463515609;9826.164775993977;10100.545475453622;467438;488102;488629;490418;502161;74446;74767.62616186884;75829.6208518954;76287.23712762802;79012;1150.1259043127284;1152.8674202466657;1187.6852634051984;1200.867904530501;1222.19335238742;15367.923160384127;15461.226938653248;15611.141387223812;15647.139407332706;15902;33312.666873330956;33854.66145338515;33923;34146.48780268348;34280.314393712484;46256.30615540702;46574.30138547992;46670.53329466662;47246.291305629755;47685.28472072991;7506.474546781673;7680.923190768244;7790.14308426084;7811.140774514913;7820.100688420905;8786.824263514565;11054.944725276322;11065.170112241452;11201.215914886207;11311;10316;10385.84421233667;10561.207909406672;10637.893621063691;10638.73403164927;9894.257930655085;10277.229207809594;10403;10485.37087774736;10657;8142.552159631277;10258.640947566799;10344;10346.32748871321;10572.41851698164;7035.909434037732;7143.571385716874;7267.0552828132;7281.19906810261;7646.470705858739;10073.244506661884;10195.263523335048;10235.181185505291;10562.155027597928;10780.676579702622 11:49:42 INFO - PROCESS | 22563 | |3;mootools.html;1360.4558176729313;1471.4114354258295;1471.7056588682262;1665.575278304033;1844.0595296398842;7084.822879428017;7611.733589324374;7823.374130069595;7823.882641760371;7825.256600622946;7817.765467035983;7921.485103468271;7952.76141715748;7979.840403191947;7987;2014.2345908554803;2037.0731317250616;2235.6311208650554;2308.3190458814647;2334.708161479815;2292.060255295329;2295.3114065780283;2298.4368829636765;2300.424893776556;2300.9539809203807;2232.408411770882;2314.907403703858;2317.7218733751974;2322.837401381904;2323.744388117314;2266.897989590464;2306.9653955190684;2333.1367394064137;2336.4742932840145;2337.7779110984516;2277.36233854521;2292.3008482412856;2298.5058212484396;2298.804601608865;2347.0729062020405;7963.96018019912;8067.757967260933;8113.350931925491;8123.390745694097;8135.3491720662205;4811.422629284473;4854.563089321978;4898.681585696918;4903.215485522299;4905.190643543811;3159.4470967580583;3215.485522316418;3244.545763593099;3259.885903993349;3266.5753452051317;998.5805961496189;1025.6153942271649;1051.7791263834604;1057.9682609521726;1066.1630619963291;11164.553417863275;11215.887841121566;11227.157963152797;11235.325880447117;11235.719107022309;4204.957950420457;4292.978535107304;4321.67587430944;4341.758872548056;4357.694961352739;9531.189848862925;9586.28102892272;9600.903990960142;9621.27840411972;9622.085901839315;4825.131476334293;4845.442774081026;4861.222204447272;4863.610911127102;4866.8783280417565;4386.385905973167;4428.114377124588;4433.756143412079;4436.778161091933;4436.889077773017;3362.5628668273457;3518.1908161123083;3599.3881040223223;3663.5420572428447;3686.870959516458;1173.6068417080203;1180.2446434282067;1186.2704436771323;1186.8694443611196;1194.0387987670008;1116.1461481966303;1136.1478890831877;1136.3920302638214;1314.185205172799;1389.5345059405213;7529.8117547060665;7587.696492140252;7624.42816788743;7634.847303053908;7637.198094200029;1141.543382646948;1145.278474561038;1147.1740346950182;1154.936478493674;1161.8547681539808;6002.729877155539;6122.418370254819;6123.571350005546;6138.232720909887;6144.907826382608;9378.90621093794;9920.851187232198;9922.255830812717;9925.65260215889;9950.950245248727;9785.412875227366;9807.509624518745;9890.505474726235;9911.157551608194;9929;7378.520396174232;7696.384289256846;7707.691692332356;7772.106207786064;7795.766127016085;7332.816679583053;7370.926290737024;7430.7399241026305;7436.107667079985;7436.96281518589;8638.78403039904;8713.607887645197;8742.125787421208;8753.824923501621;8782.165694259034;8864.86702699447;8972.910270897468;9156.450612963243;9160.908390916005;9319.114684105;6976.6860491277;7018.508704390643;7031.156261248479;7035.964820175866;7046.612436315847;6885.965570172117;7325.816854578678;7544.396448284015;7548.207438218908;7551.358134558404;7204.231325782231;7364.631768411451;7425.777226683208;7445.7766267012075;7563.621818908922;7008.194057683228;7025.718971241297;7079.22128565847;7247.166575843635;7256.89114663291;7139.964300178466;7199.172095209118;7257.564546127249;7308.744193953186;7313.158986716596;6728.663566821541;6777.89833152513;6783.660816959231;6804.795856124324;6809.65951702403;6856.108705868205;6857.314268573103;6909.205441374306;6914.343137401939;6970.825729356807 11:49:42 INFO - PROCESS | 22563 | |4;prototype.html;327.7099766706465;331.1704181026529;341.18456888037593;348.90753950203185;354.36037951497536;5825.8834823303505;6022.217111775474;6024.548158888085;6059.182010428591;6082.847928801777;5786.132080187974;5954.255718035246;5975.432333928281;5984.072468767348;6000.879982400349;4660.6504512161555;4671.509491503394;4676.906461870761;4678.929816052762;4681.461631912322;4431.1802316571375;4489.147062058215;4620.584147426731;4641.837535686252;4644.558766917155;4562.361269422284;4573.245414506602;4585.060062687157;4592.288195329729;4603.746793926332;4608.5161058088925;4638.8608341749805;4644.651651126179;4650.7442090685;4655.25515917455;4085.3259212229946;4090.4682391288943;4093.263212621727;4094.0379010932406;4097.44684467596;5653.830385088454;5741.511971482429;5749.1663708762;5751.079827227623;5760.279965004374;5418.160185171305;5420.864478388033;5423.593230507728;5427.104527752916;5429.4027656957705;6077.483413909823;6372.872542549123;6383.170187875593;6402.551821372505;6407.135036770023;4432.312991486293;4524.773761311922;4532.161550113239;4538.591526762607;4542.205114105019;6632.336766323378;6646.767363142267;6647.401733843977;6658.966705166492;6664.766733164364;4635.420572428447;4635.814567417333;4636.791344389443;4637.234856248681;4638.002829391697;4613.146567884952;4616.630669546428;4687.718736875799;4699.741514216683;4716.716996980193;5385.649932754359;5396.055690254189;5396.109641909041;5398.109311963561;5400.081986062379;6429.971204607334;6434.839129021719;6444.226692796894;6445.291017988017;6446.77436289737;1642.1132588402368;1665.1341302522862;1666.758320043587;1668.607877148869;1669.991650041742;1049.761281687616;1064.3347907557777;1066.648006157966;1153.532819208222;1162.924409913353;5926.170336152942;5995.640261584319;5999.07014412758;6002.579819412599;6006.159137720722;6398.584092034003;6458.61248325102;6511.28375878653;6516.218053833571;6527.51043671717;5832.679202643895;5980.73086711099;5985.730642121115;5985.940140598538;5986.341502434729;3490.8254587270535;3530.064532898784;3531.2231309111953;3531.6291789362263;3533.1520435095904;6806.4554835613035;6811.284815094443;6812.046313516112;6816.420604248595;6820.454363650896;6648.002799580005;6659.2008958925235;6660.23407308156;6663.4669226461765;6670.466362690973;6688.264290927994;6920.757773478005;6951.756688515979;6976.511644184859;6978.79063628092;6310.368963103653;6504.349565043458;6646;6647.966760166169;6650.102236198051;6553.705083271169;6583.80248592543;6584.835379115369;6585.440237579859;6590.5716128451495;6940.340667636567;6946.861062778615;6951.096357473496;6953.895691564529;6956.8956465652045;4376.737395756265;4450.955490445054;4491.685582009228;4518.525554816697;4534.818607255673;6608.933910660832;6618.735250590115;6628.5028622852515;6628.83427914306;6629.370209830058;6466.224053113657;6468.611883287018;6473.611583305017;6474.805755827333;6478.1578394808375;6265.185525881606;6445;6449.677516124269;6495.0582165586675;6500.349965003462;6309.779157729457;6334.556581039283;6334.841628959313;6335.334789847184;6350.650714210763;6520.18497687789;6522.34776522344;6525.869482610226;6527.771527996498;6529.118568993315;6205.162303089025;6357.442426605511;6367.90448143269;6372.267189273108;6375.7449702013255 11:49:42 INFO - PROCESS | 22563 | |5;yui.html;698.4377576051277;722.7723267170841;732.1104857598019;813.9348852091833;821.568676444866;12644.367781610928;12962.740745185103;12983;12994.610161695164;13003.349832508373;12171.695707607292;12239.510419583206;12242.510299588006;12246.755064898696;12257.938710306458;663.0882536512296;681.3016657925641;797.6609940775162;818.153211426174;838.6393850644221;821.256762629821;827.611022819277;830.1408042675831;830.9667613295492;832.0348395860802;694.8228201808532;864.0754392799707;865.6148014133713;866.376209129429;866.6273502393999;838.8909441772561;853.8761879527434;858.0947100808644;858.716623514242;861.8707193920899;640.4844100499097;641.5284765697209;641.621443348422;641.6727468990848;641.6823672282203;12174.452149653287;12196.634100976986;12224.2665440073;12249.93875030628;12322.81515777264;11899.345535995517;11906.523739050428;12104.208018067813;12309.753804923941;12564.308963007032;10229.64196253135;10288.382697038202;10350.171986241157;10514.737131571772;10641.467926603638;4045.0898547826796;4218.810153543098;4225.619694227504;4276.593723596254;4287.249731297011;48336.7583162089;48547.514524855;48843.755781221225;48843.755781221225;48944.510554894354;9579.616815327308;9803.558839852223;10036.096751292418;10250.641227557;10259.384436933808;16857.915710421614;16866.915665421595;16907.408240711517;17376.65246695059;17379.47861564155;7412.962935185397;7503.512271702322;7517.887231691529;7593.962030189814;7741.729039483591;4097.180563887235;4173.269677806372;4302.548232435612;4346.826126954887;4440.222960981815;3092.8608212630484;3125.8280794556517;3126.2965832687464;3131.2171957010746;3142.7328677062706;606.9575129740875;607.134832863177;610.255488304268;628.5097623853402;630.4389093706604;604.5465900574569;613.3467856732655;628.6699482771581;637.6333608175318;666.8199586111723;8111.594420278962;8122.147174546706;8199.590020498952;8280.917190828135;8583.289364964057;488.182294656449;518.7665550502289;529.3013222546202;537.2290762755381;585.8740370820294;3575.3028159508644;3710.5361829771277;3965.385365268388;3995.081131339808;4099.426080348753;56680.71659641758;56990.43009569934;57006.429935700944;57056.14415783767;57122.14316785252;51463.742681286356;52082.47917520852;52576.21135682968;52589.737051315264;52775;44877.55122448734;45366;45577.54422455799;45581.31628025582;45765.542344576796;7723.729669461766;7960.124386317385;8037.879431808645;8138.104808471182;8215.137410572042;33624.49563256504;33775;34262.65737342694;34354.82822585871;34355.82822085873;40577;41774;42504.57495425006;44209.33685994777;45112.77443612761;10273.589056437659;10317.9484102579;10357.119644830274;10392.48037598102;10410.843837342294;10836.241463097507;10990.340579565252;11105.278156919774;11119.221654484432;11197.944010279896;10353.275270730977;10558.577656893945;10630.73423164427;10644.308119972176;10710.250282480152;9919.206463483048;10077.445740484343;10107.343022703795;10121.392716436743;10143.188544916242;10192.439415832201;10467;10469.738256543647;10479.842802357818;10603.310784798963;8471.449355791854;8557.445027013007;8637.093105223861;8739.868901966349;8950.462972221687;8494.872576911228;8498.787530311793;8689.478631282143;8769.473831570127;9264.629414823332 11:49:42 INFO - PROCESS | 22563 | __end_tp_report 11:49:42 INFO - PROCESS | 22563 | __start_cc_report 11:49:42 INFO - PROCESS | 22563 | _x_x_mozilla_cycle_collect,791 11:49:42 INFO - PROCESS | 22563 | __end_cc_report 11:49:42 INFO - PROCESS | 22563 | __startTimestamp1455047382788__endTimestamp 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | ------- Summary: start ------- 11:49:42 INFO - PROCESS | 22563 | Number of tests: 6 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#0] dojo.html Cycles:165 Average:5227.68 Median:5462.24 stddev:677.14 (12.4%) stddev-sans-first:659.06 11:49:42 INFO - PROCESS | 22563 | Values: 3137.4 3205.9 3254.2 3255.7 3271.9 5185.3 5203.5 5230.6 5256.5 5291.5 5215.9 5222.6 5274.0 5276.9 5313.6 4786.4 4811.4 4816.1 4841.8 4917.7 534.3 4758.8 4838.9 4894.0 4894.9 4751.7 4815.7 4852.4 4863.5 4896.0 4788.5 4804.5 4804.7 4811.9 4851.2 4748.3 4785.5 4816.9 4821.1 4851.8 5125.8 5148.0 5180.1 5192.4 5219.5 5568.1 5574.9 5580.9 5582.6 5591.4 5554.3 5557.8 5635.7 5638.1 5649.4 5284.7 5293.8 5295.3 5311.3 5345.3 5741.8 5759.3 5765.5 5782.2 5782.4 5518.4 5545.5 5546.2 5559.5 5577.5 5703.2 5706.5 5708.3 5708.9 5713.8 5645.3 5648.9 5683.4 5686.7 5691.4 5593.6 5641.2 5656.0 5678.7 5760.2 4363.7 4365.0 4373.0 4377.6 4406.8 3911.8 3913.6 3916.4 3949.1 3964.5 5171.2 5236.6 5245.1 5295.1 5332.4 5643.3 5647.3 5655.5 5672.0 5676.1 5190.4 5251.4 5254.6 5262.7 5305.7 4786.2 4800.9 4825.3 4834.3 4869.0 5881.4 5886.1 5891.1 5902.0 5909.4 5514.2 5659.2 5661.9 5675.8 5707.5 5840.3 5874.9 5896.9 5907.7 5910.3 5558.9 5564.2 5575.5 5581.5 5599.3 5561.4 5629.6 5647.2 5653.9 5657.8 5545.4 5582.2 5588.2 5590.8 5615.3 5540.2 5552.2 5563.3 5568.9 5578.2 5358.1 5428.9 5462.2 5512.2 5515.3 5530.6 5535.2 5543.6 5544.1 5584.6 5410.5 5413.3 5417.6 5419.6 5434.7 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#1] ext.html Cycles:180 Average:44561.62 Median:30672.31 stddev:72666.68 (236.9%) stddev-sans-first:72795.21 11:49:42 INFO - PROCESS | 22563 | Values: 497.5 525.0 533.6 538.0 549.9 28011.6 28865.1 36575.8 37046.8 37152.3 39950.0 40524.0 40524.2 40563.4 40591.0 7428.9 7488.5 8459.1 8668.3 8668.6 10312.0 10576.1 10602.5 10613.7 10618.1 10304.4 10399.9 10401.8 10420.3 10421.1 10198.6 10274.2 10288.5 10305.8 10308.1 10108.8 10295.7 10296.5 10598.0 10601.7 40048.8 40376.8 40378.4 40474.8 40522.0 3206.3 3324.9 3403.6 3646.9 3878.0 29647.9 29879.9 30689.1 31200.5 31396.0 3923.5 3984.8 4024.3 4074.5 4086.8 256576.0 259502.0 260613.0 260899.0 261315.0 51470.2 58488.0 58891.4 58977.0 59384.1 53068.2 53617.5 53697.0 53918.0 53957.7 15780.4 15937.2 15947.7 15972.9 15974.8 12360.3 12429.4 12430.5 12439.6 12483.4 18776.6 18950.1 19553.0 19555.5 19668.7 7828.6 7932.4 8018.6 8040.7 8062.0 988.9 1096.1 1102.9 1112.8 1211.0 29003.0 29208.0 29693.6 30249.5 30316.5 1071.4 1095.6 1096.3 1101.8 1130.2 15911.4 16088.4 16309.4 16331.8 16586.3 291942.0 296092.0 296727.0 296759.0 297227.0 52677.2 52786.5 52882.2 52899.2 53052.7 1369.1 1372.9 1381.4 1390.1 1398.4 29462.0 30270.8 30347.4 30655.5 30888.7 41740.6 41772.8 41995.0 42003.6 42066.2 264854.0 282806.0 283420.0 285507.0 286184.0 30114.8 30620.4 30692.5 30988.4 31032.5 35635.5 36326.3 36371.8 37012.3 37103.6 32513.7 33076.5 33394.5 33702.7 38239.8 28239.7 32158.8 33816.6 33976.0 35975.9 33112.0 33737.3 34004.8 34014.7 34105.0 29172.9 31452.0 31867.7 31986.5 32056.4 24427.0 24737.8 24806.1 25081.7 25110.5 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#2] jquery.html Cycles:180 Average:26411.01 Median:370.40 stddev:79843.80 (21555.9%) stddev-sans-first:80043.84 11:49:42 INFO - PROCESS | 22563 | Values: 370.1 370.7 372.2 373.4 377.4 14033.6 14119.0 16515.8 17255.3 17909.1 16363.0 16491.4 16804.2 16833.0 16891.5 3841.7 4900.7 5130.0 5137.1 5138.2 5169.3 5426.8 5432.8 5433.2 5436.7 5252.6 5333.0 5373.5 5397.2 5404.1 5149.7 5353.9 5356.8 5369.9 5371.2 5349.4 5362.2 5365.7 5365.7 5366.7 12385.4 12927.0 12931.8 12933.6 20047.4 2070.4 2184.0 2307.7 2558.9 2746.6 9306.4 9657.1 9869.1 10020.2 12086.3 1718.2 1786.7 1837.5 1916.1 1967.4 56867.0 62481.7 63740.0 64097.8 64142.7 10103.7 10211.7 10215.5 10334.3 10386.3 12841.1 13583.2 13593.4 13636.4 13645.7 7355.7 7388.9 7415.3 7647.8 7725.8 6980.1 7009.3 7021.5 7661.4 7720.3 4147.5 4298.2 4319.8 4438.6 4486.1 1765.5 1804.3 1846.1 1849.4 1863.2 937.6 961.3 963.1 1003.9 1037.8 15791.8 16131.3 16199.7 16832.4 17089.0 977.6 978.3 1011.7 1021.5 1031.4 9491.8 9590.3 9710.2 9826.2 10100.5 467438.0 488102.0 488629.0 490418.0 502161.0 74446.0 74767.6 75829.6 76287.2 79012.0 1150.1 1152.9 1187.7 1200.9 1222.2 15367.9 15461.2 15611.1 15647.1 15902.0 33312.7 33854.7 33923.0 34146.5 34280.3 46256.3 46574.3 46670.5 47246.3 47685.3 7506.5 7680.9 7790.1 7811.1 7820.1 8786.8 11054.9 11065.2 11201.2 11311.0 10316.0 10385.8 10561.2 10637.9 10638.7 9894.3 10277.2 10403.0 10485.4 10657.0 8142.6 10258.6 10344.0 10346.3 10572.4 7035.9 7143.6 7267.1 7281.2 7646.5 10073.2 10195.3 10235.2 10562.2 10780.7 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#3] mootools.html Cycles:180 Average:5649.86 Median:6780.78 stddev:2963.35 (43.7%) stddev-sans-first:2954.12 11:49:42 INFO - PROCESS | 22563 | Values: 1360.5 1471.4 1471.7 1665.6 1844.1 7084.8 7611.7 7823.4 7823.9 7825.3 7817.8 7921.5 7952.8 7979.8 7987.0 2014.2 2037.1 2235.6 2308.3 2334.7 2292.1 2295.3 2298.4 2300.4 2301.0 2232.4 2314.9 2317.7 2322.8 2323.7 2266.9 2307.0 2333.1 2336.5 2337.8 2277.4 2292.3 2298.5 2298.8 2347.1 7964.0 8067.8 8113.4 8123.4 8135.3 4811.4 4854.6 4898.7 4903.2 4905.2 3159.4 3215.5 3244.5 3259.9 3266.6 998.6 1025.6 1051.8 1058.0 1066.2 11164.6 11215.9 11227.2 11235.3 11235.7 4205.0 4293.0 4321.7 4341.8 4357.7 9531.2 9586.3 9600.9 9621.3 9622.1 4825.1 4845.4 4861.2 4863.6 4866.9 4386.4 4428.1 4433.8 4436.8 4436.9 3362.6 3518.2 3599.4 3663.5 3686.9 1173.6 1180.2 1186.3 1186.9 1194.0 1116.1 1136.1 1136.4 1314.2 1389.5 7529.8 7587.7 7624.4 7634.8 7637.2 1141.5 1145.3 1147.2 1154.9 1161.9 6002.7 6122.4 6123.6 6138.2 6144.9 9378.9 9920.9 9922.3 9925.7 9951.0 9785.4 9807.5 9890.5 9911.2 9929.0 7378.5 7696.4 7707.7 7772.1 7795.8 7332.8 7370.9 7430.7 7436.1 7437.0 8638.8 8713.6 8742.1 8753.8 8782.2 8864.9 8972.9 9156.5 9160.9 9319.1 6976.7 7018.5 7031.2 7036.0 7046.6 6886.0 7325.8 7544.4 7548.2 7551.4 7204.2 7364.6 7425.8 7445.8 7563.6 7008.2 7025.7 7079.2 7247.2 7256.9 7140.0 7199.2 7257.6 7308.7 7313.2 6728.7 6777.9 6783.7 6804.8 6809.7 6856.1 6857.3 6909.2 6914.3 6970.8 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#4] prototype.html Cycles:180 Average:5360.70 Median:5990.99 stddev:1606.09 (26.8%) stddev-sans-first:1565.54 11:49:42 INFO - PROCESS | 22563 | Values: 327.7 331.2 341.2 348.9 354.4 5825.9 6022.2 6024.5 6059.2 6082.8 5786.1 5954.3 5975.4 5984.1 6000.9 4660.7 4671.5 4676.9 4678.9 4681.5 4431.2 4489.1 4620.6 4641.8 4644.6 4562.4 4573.2 4585.1 4592.3 4603.7 4608.5 4638.9 4644.7 4650.7 4655.3 4085.3 4090.5 4093.3 4094.0 4097.4 5653.8 5741.5 5749.2 5751.1 5760.3 5418.2 5420.9 5423.6 5427.1 5429.4 6077.5 6372.9 6383.2 6402.6 6407.1 4432.3 4524.8 4532.2 4538.6 4542.2 6632.3 6646.8 6647.4 6659.0 6664.8 4635.4 4635.8 4636.8 4637.2 4638.0 4613.1 4616.6 4687.7 4699.7 4716.7 5385.6 5396.1 5396.1 5398.1 5400.1 6430.0 6434.8 6444.2 6445.3 6446.8 1642.1 1665.1 1666.8 1668.6 1670.0 1049.8 1064.3 1066.6 1153.5 1162.9 5926.2 5995.6 5999.1 6002.6 6006.2 6398.6 6458.6 6511.3 6516.2 6527.5 5832.7 5980.7 5985.7 5985.9 5986.3 3490.8 3530.1 3531.2 3531.6 3533.2 6806.5 6811.3 6812.0 6816.4 6820.5 6648.0 6659.2 6660.2 6663.5 6670.5 6688.3 6920.8 6951.8 6976.5 6978.8 6310.4 6504.3 6646.0 6648.0 6650.1 6553.7 6583.8 6584.8 6585.4 6590.6 6940.3 6946.9 6951.1 6953.9 6956.9 4376.7 4451.0 4491.7 4518.5 4534.8 6608.9 6618.7 6628.5 6628.8 6629.4 6466.2 6468.6 6473.6 6474.8 6478.2 6265.2 6445.0 6449.7 6495.1 6500.3 6309.8 6334.6 6334.8 6335.3 6350.7 6520.2 6522.3 6525.9 6527.8 6529.1 6205.2 6357.4 6367.9 6372.3 6375.7 11:49:42 INFO - PROCESS | 22563 | 11:49:42 INFO - PROCESS | 22563 | [#5] yui.html Cycles:180 Average:13416.40 Median:45673.43 stddev:15862.96 (34.7%) stddev-sans-first:15878.71 11:49:42 INFO - PROCESS | 22563 | Values: 698.4 722.8 732.1 813.9 821.6 12644.4 12962.7 12983.0 12994.6 13003.3 12171.7 12239.5 12242.5 12246.8 12257.9 663.1 681.3 797.7 818.2 838.6 821.3 827.6 830.1 831.0 832.0 694.8 864.1 865.6 866.4 866.6 838.9 853.9 858.1 858.7 861.9 640.5 641.5 641.6 641.7 641.7 12174.5 12196.6 12224.3 12249.9 12322.8 11899.3 11906.5 12104.2 12309.8 12564.3 10229.6 10288.4 10350.2 10514.7 10641.5 4045.1 4218.8 4225.6 4276.6 4287.2 48336.8 48547.5 48843.8 48843.8 48944.5 9579.6 9803.6 10036.1 10250.6 10259.4 16857.9 16866.9 16907.4 17376.7 17379.5 7413.0 7503.5 7517.9 7594.0 7741.7 4097.2 4173.3 4302.5 4346.8 4440.2 3092.9 3125.8 3126.3 3131.2 3142.7 607.0 607.1 610.3 628.5 630.4 604.5 613.3 628.7 637.6 666.8 8111.6 8122.1 8199.6 8280.9 8583.3 488.2 518.8 529.3 537.2 585.9 3575.3 3710.5 3965.4 3995.1 4099.4 56680.7 56990.4 57006.4 57056.1 57122.1 51463.7 52082.5 52576.2 52589.7 52775.0 44877.6 45366.0 45577.5 45581.3 45765.5 7723.7 7960.1 8037.9 8138.1 8215.1 33624.5 33775.0 34262.7 34354.8 34355.8 40577.0 41774.0 42504.6 44209.3 45112.8 10273.6 10317.9 10357.1 10392.5 10410.8 10836.2 10990.3 11105.3 11119.2 11197.9 10353.3 10558.6 10630.7 10644.3 10710.3 9919.2 10077.4 10107.3 10121.4 10143.2 10192.4 10467.0 10469.7 10479.8 10603.3 8471.4 8557.4 8637.1 8739.9 8950.5 8494.9 8498.8 8689.5 8769.5 9264.6 11:49:42 INFO - PROCESS | 22563 | -------- Summary: end -------- 11:49:42 INFO - PROCESS | 22563 | 11:49:43 INFO - TEST-INFO | 22563: exit 0 11:49:43 INFO - TEST-OK | dromaeo_css | took 1111655ms 11:49:43 INFO - TEST-START | kraken 11:49:43 INFO - operating with platform_type : linux_ 11:49:43 INFO - Initialising browser for kraken test... 11:49:43 INFO - TEST-INFO | started process 22743 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHNKwc_/profile http://localhost:58364/getInfo.html) 11:49:47 INFO - PROCESS | 22743 | __metrics Screen width/height:1600/1200 11:49:47 INFO - PROCESS | 22743 | colorDepth:24 11:49:47 INFO - PROCESS | 22743 | Browser inner width/height: 1024/697 11:49:47 INFO - PROCESS | 22743 | __metrics 11:49:47 INFO - PROCESS | 22743 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:47 INFO - PROCESS | 22743 | 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. 11:49:48 INFO - TEST-INFO | 22743: exit 0 11:49:48 INFO - Browser initialized. 11:49:48 INFO - Running cycle 1/1 for kraken test... 11:49:48 INFO - TEST-INFO | started process 22825 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHNKwc_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:00 INFO - PROCESS | 22825 | RSS: Main: 149663744 11:50:00 INFO - PROCESS | 22825 | 11:50:02 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58364/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:03 INFO - PROCESS | 22825 | RSS: Main: 189313024 11:50:03 INFO - PROCESS | 22825 | 11:50:05 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58364/tests/kraken/driver.html?testName=audio-dft) 11:50:06 INFO - PROCESS | 22825 | RSS: Main: 179089408 11:50:06 INFO - PROCESS | 22825 | 11:50:09 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58364/tests/kraken/driver.html?testName=audio-fft) 11:50:09 INFO - PROCESS | 22825 | RSS: Main: 164077568 11:50:09 INFO - PROCESS | 22825 | 11:50:11 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58364/tests/kraken/driver.html?testName=audio-oscillator) 11:50:12 INFO - PROCESS | 22825 | RSS: Main: 166924288 11:50:12 INFO - PROCESS | 22825 | 11:50:14 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:15 INFO - PROCESS | 22825 | RSS: Main: 167718912 11:50:15 INFO - PROCESS | 22825 | 11:50:18 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58364/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:18 INFO - PROCESS | 22825 | RSS: Main: 168701952 11:50:18 INFO - PROCESS | 22825 | 11:50:22 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58364/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:22 INFO - PROCESS | 22825 | RSS: Main: 168894464 11:50:22 INFO - PROCESS | 22825 | 11:50:25 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58364/tests/kraken/driver.html?testName=json-parse-financial) 11:50:26 INFO - PROCESS | 22825 | RSS: Main: 169058304 11:50:26 INFO - PROCESS | 22825 | 11:50:27 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:28 INFO - PROCESS | 22825 | RSS: Main: 184950784 11:50:28 INFO - PROCESS | 22825 | 11:50:30 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:30 INFO - PROCESS | 22825 | RSS: Main: 179548160 11:50:30 INFO - PROCESS | 22825 | 11:50:32 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:33 INFO - PROCESS | 22825 | RSS: Main: 189366272 11:50:33 INFO - PROCESS | 22825 | 11:50:35 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:36 INFO - PROCESS | 22825 | RSS: Main: 193953792 11:50:36 INFO - PROCESS | 22825 | 11:50:39 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:39 INFO - PROCESS | 22825 | RSS: Main: 194613248 11:50:39 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | Cycle 1(1): loaded http://localhost:58364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58364/tests/kraken/driver.html?testName=ai-astar) 11:50:41 INFO - PROCESS | 22825 | RSS: Main: 254902272 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | __start_tp_report 11:50:41 INFO - PROCESS | 22825 | _x_x_mozilla_page_load 11:50:41 INFO - PROCESS | 22825 | _x_x_mozilla_page_load_details 11:50:41 INFO - PROCESS | 22825 | |i|pagename|runs| 11:50:41 INFO - PROCESS | 22825 | |0;ai-astar;108;112;106;109;110;110;98;109;108;110 11:50:41 INFO - PROCESS | 22825 | |1;audio-beat-detection;152;126;151;172;128;149;148;135;172;124 11:50:41 INFO - PROCESS | 22825 | |2;audio-dft;161;160;161;160;160;161;159;162;161;161 11:50:41 INFO - PROCESS | 22825 | |3;audio-fft;73;73;99;108;74;74;72;119;101;79 11:50:41 INFO - PROCESS | 22825 | |4;audio-oscillator;97;96;141;96;96;96;143;95;97;139 11:50:41 INFO - PROCESS | 22825 | |5;imaging-gaussian-blur;119;115;115;115;115;114;114;114;115;114 11:50:41 INFO - PROCESS | 22825 | |6;imaging-darkroom;146;146;145;145;145;145;146;145;146;147 11:50:41 INFO - PROCESS | 22825 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;96;95 11:50:41 INFO - PROCESS | 22825 | |8;json-parse-financial;57;57;58;57;56;56;59;67;55;55 11:50:41 INFO - PROCESS | 22825 | |9;json-stringify-tinderbox;66;67;66;66;67;67;67;67;67;69 11:50:41 INFO - PROCESS | 22825 | |10;stanford-crypto-aes;89;85;85;85;85;85;86;85;86;85 11:50:41 INFO - PROCESS | 22825 | |11;stanford-crypto-ccm;116;115;114;115;127;127;119;116;116;115 11:50:41 INFO - PROCESS | 22825 | |12;stanford-crypto-pbkdf2;147;148;154;158;153;147;148;154;170;155 11:50:41 INFO - PROCESS | 22825 | |13;stanford-crypto-sha256-iterative;69;73;72;69;70;67;71;74;69;70 11:50:41 INFO - PROCESS | 22825 | __end_tp_report 11:50:41 INFO - PROCESS | 22825 | __start_cc_report 11:50:41 INFO - PROCESS | 22825 | _x_x_mozilla_cycle_collect,987 11:50:41 INFO - PROCESS | 22825 | __end_cc_report 11:50:41 INFO - PROCESS | 22825 | __startTimestamp1455047441653__endTimestamp 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | ------- Summary: start ------- 11:50:41 INFO - PROCESS | 22825 | Number of tests: 14 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:4.09 11:50:41 INFO - PROCESS | 22825 | Values: 108.0 112.0 106.0 109.0 110.0 110.0 98.0 109.0 108.0 110.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:150.00 stddev:17.49 (11.7%) stddev-sans-first:18.41 11:50:41 INFO - PROCESS | 22825 | Values: 152.0 126.0 151.0 172.0 128.0 149.0 148.0 135.0 172.0 124.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 11:50:41 INFO - PROCESS | 22825 | Values: 161.0 160.0 161.0 160.0 160.0 161.0 159.0 162.0 161.0 161.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.50 stddev:17.71 (24.1%) stddev-sans-first:18.03 11:50:41 INFO - PROCESS | 22825 | Values: 73.0 73.0 99.0 108.0 74.0 74.0 72.0 119.0 101.0 79.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.70 (22.6%) stddev-sans-first:22.53 11:50:41 INFO - PROCESS | 22825 | Values: 97.0 96.0 141.0 96.0 96.0 96.0 143.0 95.0 97.0 139.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 11:50:41 INFO - PROCESS | 22825 | Values: 119.0 115.0 115.0 115.0 115.0 114.0 114.0 114.0 115.0 114.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:50:41 INFO - PROCESS | 22825 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 147.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:50:41 INFO - PROCESS | 22825 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.50 (6.1%) stddev-sans-first:3.70 11:50:41 INFO - PROCESS | 22825 | Values: 57.0 57.0 58.0 57.0 56.0 56.0 59.0 67.0 55.0 55.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 11:50:41 INFO - PROCESS | 22825 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 67.0 69.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:0.44 11:50:41 INFO - PROCESS | 22825 | Values: 89.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 86.0 85.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:116.00 stddev:4.92 (4.2%) stddev-sans-first:5.17 11:50:41 INFO - PROCESS | 22825 | Values: 116.0 115.0 114.0 115.0 127.0 127.0 119.0 116.0 116.0 115.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.00 stddev:7.00 (4.5%) stddev-sans-first:7.03 11:50:41 INFO - PROCESS | 22825 | Values: 147.0 148.0 154.0 158.0 153.0 147.0 148.0 154.0 170.0 155.0 11:50:41 INFO - PROCESS | 22825 | 11:50:41 INFO - PROCESS | 22825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.12 (3.0%) stddev-sans-first:2.19 11:50:41 INFO - PROCESS | 22825 | Values: 69.0 73.0 72.0 69.0 70.0 67.0 71.0 74.0 69.0 70.0 11:50:41 INFO - PROCESS | 22825 | -------- Summary: end -------- 11:50:41 INFO - PROCESS | 22825 | 11:50:42 INFO - TEST-INFO | 22825: exit 0 11:50:42 INFO - TEST-OK | kraken | took 59026ms 11:50:42 INFO - SUITE-END | took 1170s 11:50:42 INFO - Completed test suite (00:19:30) 11:50:42 INFO - Working with test: dromaeo_css 11:50:42 INFO - Generating results file: dromaeo_css 11:50:42 INFO - Working with test: kraken 11:50:42 INFO - Generating results file: kraken 11:50:42 INFO - javascript benchmark 11:50:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:50:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:50:42 INFO - process_Request line: dromaeo_css 6905.94 graph.html#tests=[[72,64,35]] 11:50:42 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:50:42 INFO - process_Request line: kraken 1519.20 graph.html#tests=[[232,64,35]] 11:50:42 INFO - RETURN: dromaeo_css: 6905.94 11:50:42 INFO - RETURN: kraken: 1519.20 11:50:42 INFO - javascript benchmark 11:50:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.435261652902, 3205.903822885314, 3254.1701866024146, 3255.658155893631, 3271.86912523499, 5185.274061631375, 5203.53168214861, 5230.633855630107, 5256.474352564746, 5291.523762861341, 5215.86960325992, 5222.608304377178, 5274.0, 5276.947230527693, 5313.601479889005, 4786.353842231289, 4811.374521312225, 4816.060868130716, 4841.782119804618, 4917.655764096515, 534.2898927106205, 4758.833440829571, 4838.927416088762, 4894.045661096087, 4894.926576101361, 4751.714897106167, 4815.735134567597, 4852.417709874838, 4863.537963893442, 4896.0, 4788.545088216614, 4804.5195480451675, 4804.687695299829, 4811.879703007417, 4851.175300198939, 4748.264019077049, 4785.521447855222, 4816.879578010543, 4821.132196204681, 4851.757412129415, 5125.846224613268, 5148.047611191904, 5180.093483640386, 5192.402873669501, 5219.4780521947505, 5568.109102543614, 5574.944250557483, 5580.91628625571, 5582.581306402036, 5591.3569939457075, 5554.305711786027, 5557.805476808333, 5635.746391412396, 5638.069718496443, 5649.350324712669, 5284.682919024871, 5293.761780719877, 5295.258663787073, 5311.256424100629, 5345.251664766897, 5741.7990370337675, 5759.337676167211, 5765.538756899438, 5782.2483077199695, 5782.392848750821, 5518.392976772552, 5545.500904918576, 5546.195801608825, 5559.499645031967, 5577.470140336662, 5703.17303990919, 5706.457886500859, 5708.343540492813, 5708.942910570924, 5713.800016999385, 5645.322561292671, 5648.8870222595315, 5683.403242659544, 5686.687232202185, 5691.430856914359, 5593.608447408642, 5641.210230567724, 5656.038473459522, 5678.687672177987, 5760.164776107441, 4363.694541382136, 4365.017870979004, 4373.037931655031, 4377.649788016951, 4406.7576283304725, 3911.843526258918, 3913.5695073541888, 3916.4321173429694, 3949.071968087497, 3964.4647972523917, 5171.172612382001, 5236.633435659467, 5245.0558899398475, 5295.073362161684, 5332.3867755207875, 5643.294588176478, 5647.29408823897, 5655.4910058094965, 5671.971640141773, 5676.063449530781, 5190.351206099238, 5251.396089449686, 5254.579633629301, 5262.736863156827, 5305.681659100389, 4786.234202527578, 4800.903981920412, 4825.276208568673, 4834.299026641117, 4868.9756551217015, 5881.441263080001, 5886.087656413263, 5891.1457838614015, 5901.9999999999145, 5909.379515150933, 5514.228008078792, 5659.151127330769, 5661.927644847346, 5675.801346952837, 5707.486326230659, 5840.2991641003355, 5874.941250587611, 5896.852578685567, 5907.70461476933, 5910.261217347832, 5558.944410556004, 5564.19319198722, 5575.498205161555, 5581.49766521015, 5599.272094627672, 5561.360443549043, 5629.577781666473, 5647.181158731879, 5653.943460565506, 5657.830265092054, 5545.417731138334, 5582.246396736388, 5588.245586845724, 5590.7763689453595, 5615.326160860723, 5540.168974653834, 5552.222688823487, 5563.276774019351, 5568.888622227451, 5578.246936663499, 5358.062339090566, 5428.891422171613, 5462.235287059894, 5512.173174023928, 5515.283013208257, 5530.557555395479, 5535.225068490495, 5543.584231182596, 5544.112941929272, 5584.581156413204, 5410.540104091039, 5413.323334583177, 5417.593680474059, 5419.6206265562605, 5434.701091440009], "unit": "score", "name": "dojo.html", "value": 5187.065955128062}, {"lowerIsBetter": false, "replicates": [497.5372903200022, 525.0313172197294, 533.6131304804018, 538.0395993152224, 549.9340079190497, 28011.579826302623, 28865.13404597863, 36575.81712091439, 37046.8147659262, 37152.25695486089, 39950.0, 40524.0, 40524.189516209655, 40563.39154912678, 40591.0, 7428.9257107428775, 7488.513246638951, 8459.11179326171, 8668.349873759462, 8668.60991255395, 10312.0, 10576.10103141234, 10602.522886470128, 10613.73465663357, 10618.097461715763, 10304.38173709576, 10399.948000259988, 10401.84397234042, 10420.270581059329, 10421.062104410601, 10198.592056317775, 10274.178065754797, 10288.53701583423, 10305.793884122275, 10308.123809476203, 10108.797824043551, 10295.742606434824, 10296.536655850505, 10598.0, 10601.681949541526, 40048.799756001325, 40376.79811600952, 40378.394324085166, 40474.797626011976, 40522.0, 3206.3266713990092, 3324.900252992414, 3403.5745531808525, 3646.9452958205648, 3878.049877779934, 29647.851760741272, 29879.850600747075, 30689.079327620206, 31200.531992020136, 31396.0, 3923.4899463069905, 3984.820683069269, 4024.2756303865294, 4074.490688663917, 4086.8160932758096, 256576.0, 259502.0, 260613.0, 260899.0, 261315.0, 51470.22794658008, 58488.0, 58891.41108588945, 58977.0, 59384.10923836146, 53068.20397694038, 53617.46382536203, 53697.0, 53918.0, 53957.730211348695, 15780.447684331222, 15937.20313984296, 15947.681046379008, 15972.920135399481, 15974.840251597569, 12360.320182389874, 12429.37853107341, 12430.502779888704, 12439.564615238423, 12483.438245278985, 18776.624467510574, 18950.147243373805, 19553.0, 19555.51111222231, 19668.70496942547, 7828.608569571498, 7932.365410767125, 8018.639161237758, 8040.718574849852, 8062.0, 988.8566157907063, 1096.0902450965839, 1102.8841971593029, 1112.844201811747, 1210.9818352724717, 29003.0, 29208.0, 29693.554596681068, 30249.546256806167, 30316.54525182124, 1071.4321409652896, 1095.611058074388, 1096.270979798425, 1101.801675698382, 1130.1862658885589, 15911.443099491462, 16088.436904708278, 16309.42916997923, 16331.755023674654, 16586.253618587194, 291942.0, 296092.0, 296727.0, 296759.0, 297227.0, 52677.209841852404, 52786.47213527892, 52882.206766898526, 52899.206511902354, 53052.73473632607, 1369.0621923982103, 1372.8627137286392, 1381.4198036824357, 1390.1242217403174, 1398.3916996106725, 29462.0, 30270.84864575663, 30347.393052139276, 30655.54016689796, 30888.691113088582, 41740.582594174884, 41772.79113604534, 41995.0, 42003.57996419997, 42066.15867682568, 264854.0, 282806.0, 283420.0, 285507.0, 286184.0, 30114.84942575273, 30620.387592248477, 30692.539611906286, 30988.380232395677, 31032.53451198189, 35635.46546801852, 36326.27347453089, 36371.81814090913, 37012.259754805295, 37103.62896371002, 32513.67486325201, 33076.503852441754, 33394.4990825133, 33702.662973370934, 38239.80880095582, 28239.717602823708, 32158.839205803823, 33816.60854707695, 33976.0, 35975.92072237837, 33112.0, 33737.325253495284, 34004.82997584996, 34014.65985340115, 34105.0, 29172.854135729187, 31452.0, 31867.681323186473, 31986.52020219652, 32056.35887282288, 24427.0, 24737.752622474265, 24806.131785387424, 25081.749182508673, 25110.49779004446], "unit": "score", "name": "ext.html", "value": 18518.42034804718}, {"lowerIsBetter": false, "replicates": [370.07481296758107, 370.7312198655975, 372.1589208389042, 373.42119714442606, 377.4470400862739, 14033.578992630237, 14119.0, 16515.83484165158, 17255.309787608498, 17909.10454477274, 16363.0, 16491.422800201995, 16804.15979201041, 16833.0, 16891.493255202364, 3841.654251117399, 4900.705957642535, 5130.0, 5137.126688462951, 5138.152204886189, 5169.276301317818, 5426.75579598917, 5432.83701488954, 5433.239346491494, 5436.700981446019, 5252.553532949704, 5332.960072785809, 5373.489518495756, 5397.217403476494, 5404.1083221268445, 5149.665271757323, 5353.892922141555, 5356.839294821161, 5369.919451208235, 5371.248025276464, 5349.411564727877, 5362.222477740745, 5365.704886231256, 5365.704886231256, 5366.70483123428, 12385.442655080544, 12927.030472714585, 12931.806022909665, 12933.611991640266, 20047.398578042536, 2070.440980935139, 2183.9844472320287, 2307.6884620576175, 2558.8740953980373, 2746.615473833665, 9306.441613503212, 9657.130858222723, 9869.062439068277, 10020.248481363855, 12086.33525156116, 1718.183862665224, 1786.6783978883795, 1837.5406148462885, 1916.0611300462813, 1967.3704414587337, 56867.0, 62481.68759156221, 63739.999999999534, 64097.79511024477, 64142.679286603736, 10103.696889093191, 10211.7447063824, 10215.489225538693, 10334.276600638033, 10386.324888882198, 12841.101122921305, 13583.185008899498, 13593.388297526635, 13636.386362613706, 13645.727085458433, 7355.742549010866, 7388.889166662504, 7415.295546923034, 7647.770566883002, 7725.768226953201, 6980.092587963532, 7009.264027277164, 7021.473389495706, 7661.42539309554, 7720.3051725344985, 4147.460830092129, 4298.161858437575, 4319.848805291863, 4438.6005259526155, 4486.12520558488, 1765.540959350578, 1804.3143605429852, 1846.1230915315118, 1849.4359220437627, 1863.2453856188265, 937.6436953957452, 961.2886464016577, 963.1139351796364, 1003.9498025098716, 1037.8391349340864, 15791.842081579267, 16131.274092665859, 16199.676006479804, 16832.410865619644, 17089.0, 977.6382738386842, 978.2711879649564, 1011.6509804117568, 1021.5403068619152, 1031.4275577054657, 9491.810163796685, 9590.280728945358, 9710.17463515609, 9826.164775993977, 10100.545475453622, 467438.0, 488102.0, 488629.0, 490418.0, 502161.0, 74446.0, 74767.62616186884, 75829.6208518954, 76287.23712762802, 79012.0, 1150.1259043127284, 1152.8674202466657, 1187.6852634051984, 1200.867904530501, 1222.19335238742, 15367.923160384127, 15461.226938653248, 15611.141387223812, 15647.139407332706, 15902.0, 33312.666873330956, 33854.66145338515, 33923.0, 34146.48780268348, 34280.314393712484, 46256.30615540702, 46574.30138547992, 46670.53329466662, 47246.291305629755, 47685.28472072991, 7506.474546781673, 7680.923190768244, 7790.14308426084, 7811.140774514913, 7820.100688420905, 8786.824263514565, 11054.944725276322, 11065.170112241452, 11201.215914886207, 11311.0, 10316.0, 10385.84421233667, 10561.207909406672, 10637.893621063691, 10638.73403164927, 9894.257930655085, 10277.229207809594, 10403.0, 10485.37087774736, 10657.0, 8142.552159631277, 10258.640947566799, 10344.0, 10346.32748871321, 10572.41851698164, 7035.909434037732, 7143.571385716874, 7267.0552828132, 7281.19906810261, 7646.470705858739, 10073.244506661884, 10195.263523335048, 10235.181185505291, 10562.155027597928, 10780.676579702622], "unit": "score", "name": "jquery.html", "value": 8270.852844816663}, {"lowerIsBetter": false, "replicates": [1360.4558176729313, 1471.4114354258295, 1471.7056588682262, 1665.575278304033, 1844.0595296398842, 7084.822879428017, 7611.733589324374, 7823.374130069595, 7823.882641760371, 7825.256600622946, 7817.765467035983, 7921.485103468271, 7952.76141715748, 7979.840403191947, 7987.0, 2014.2345908554803, 2037.0731317250616, 2235.6311208650554, 2308.3190458814647, 2334.708161479815, 2292.060255295329, 2295.3114065780283, 2298.4368829636765, 2300.424893776556, 2300.9539809203807, 2232.408411770882, 2314.907403703858, 2317.7218733751974, 2322.837401381904, 2323.744388117314, 2266.897989590464, 2306.9653955190684, 2333.1367394064137, 2336.4742932840145, 2337.7779110984516, 2277.36233854521, 2292.3008482412856, 2298.5058212484396, 2298.804601608865, 2347.0729062020405, 7963.96018019912, 8067.757967260933, 8113.350931925491, 8123.390745694097, 8135.3491720662205, 4811.422629284473, 4854.563089321978, 4898.681585696918, 4903.215485522299, 4905.190643543811, 3159.4470967580583, 3215.485522316418, 3244.545763593099, 3259.885903993349, 3266.5753452051317, 998.5805961496189, 1025.6153942271649, 1051.7791263834604, 1057.9682609521726, 1066.1630619963291, 11164.553417863275, 11215.887841121566, 11227.157963152797, 11235.325880447117, 11235.719107022309, 4204.957950420457, 4292.978535107304, 4321.67587430944, 4341.758872548056, 4357.694961352739, 9531.189848862925, 9586.28102892272, 9600.903990960142, 9621.27840411972, 9622.085901839315, 4825.131476334293, 4845.442774081026, 4861.222204447272, 4863.610911127102, 4866.8783280417565, 4386.385905973167, 4428.114377124588, 4433.756143412079, 4436.778161091933, 4436.889077773017, 3362.5628668273457, 3518.1908161123083, 3599.3881040223223, 3663.5420572428447, 3686.870959516458, 1173.6068417080203, 1180.2446434282067, 1186.2704436771323, 1186.8694443611196, 1194.0387987670008, 1116.1461481966303, 1136.1478890831877, 1136.3920302638214, 1314.185205172799, 1389.5345059405213, 7529.8117547060665, 7587.696492140252, 7624.42816788743, 7634.847303053908, 7637.198094200029, 1141.543382646948, 1145.278474561038, 1147.1740346950182, 1154.936478493674, 1161.8547681539808, 6002.729877155539, 6122.418370254819, 6123.571350005546, 6138.232720909887, 6144.907826382608, 9378.90621093794, 9920.851187232198, 9922.255830812717, 9925.65260215889, 9950.950245248727, 9785.412875227366, 9807.509624518745, 9890.505474726235, 9911.157551608194, 9929.0, 7378.520396174232, 7696.384289256846, 7707.691692332356, 7772.106207786064, 7795.766127016085, 7332.816679583053, 7370.926290737024, 7430.7399241026305, 7436.107667079985, 7436.96281518589, 8638.78403039904, 8713.607887645197, 8742.125787421208, 8753.824923501621, 8782.165694259034, 8864.86702699447, 8972.910270897468, 9156.450612963243, 9160.908390916005, 9319.114684105, 6976.6860491277, 7018.508704390643, 7031.156261248479, 7035.964820175866, 7046.612436315847, 6885.965570172117, 7325.816854578678, 7544.396448284015, 7548.207438218908, 7551.358134558404, 7204.231325782231, 7364.631768411451, 7425.777226683208, 7445.7766267012075, 7563.621818908922, 7008.194057683228, 7025.718971241297, 7079.22128565847, 7247.166575843635, 7256.89114663291, 7139.964300178466, 7199.172095209118, 7257.564546127249, 7308.744193953186, 7313.158986716596, 6728.663566821541, 6777.89833152513, 6783.660816959231, 6804.795856124324, 6809.65951702403, 6856.108705868205, 6857.314268573103, 6909.205441374306, 6914.343137401939, 6970.825729356807], "unit": "score", "name": "mootools.html", "value": 4621.19436554426}, {"lowerIsBetter": false, "replicates": [327.7099766706465, 331.1704181026529, 341.18456888037593, 348.90753950203185, 354.36037951497536, 5825.8834823303505, 6022.217111775474, 6024.548158888085, 6059.182010428591, 6082.847928801777, 5786.132080187974, 5954.255718035246, 5975.432333928281, 5984.072468767348, 6000.879982400349, 4660.6504512161555, 4671.509491503394, 4676.906461870761, 4678.929816052762, 4681.461631912322, 4431.1802316571375, 4489.147062058215, 4620.584147426731, 4641.837535686252, 4644.558766917155, 4562.361269422284, 4573.245414506602, 4585.060062687157, 4592.288195329729, 4603.746793926332, 4608.5161058088925, 4638.8608341749805, 4644.651651126179, 4650.7442090685, 4655.25515917455, 4085.3259212229946, 4090.4682391288943, 4093.263212621727, 4094.0379010932406, 4097.44684467596, 5653.830385088454, 5741.511971482429, 5749.1663708762, 5751.079827227623, 5760.279965004374, 5418.160185171305, 5420.864478388033, 5423.593230507728, 5427.104527752916, 5429.4027656957705, 6077.483413909823, 6372.872542549123, 6383.170187875593, 6402.551821372505, 6407.135036770023, 4432.312991486293, 4524.773761311922, 4532.161550113239, 4538.591526762607, 4542.205114105019, 6632.336766323378, 6646.767363142267, 6647.401733843977, 6658.966705166492, 6664.766733164364, 4635.420572428447, 4635.814567417333, 4636.791344389443, 4637.234856248681, 4638.002829391697, 4613.146567884952, 4616.630669546428, 4687.718736875799, 4699.741514216683, 4716.716996980193, 5385.649932754359, 5396.055690254189, 5396.109641909041, 5398.109311963561, 5400.081986062379, 6429.971204607334, 6434.839129021719, 6444.226692796894, 6445.291017988017, 6446.77436289737, 1642.1132588402368, 1665.1341302522862, 1666.758320043587, 1668.607877148869, 1669.991650041742, 1049.761281687616, 1064.3347907557777, 1066.648006157966, 1153.532819208222, 1162.924409913353, 5926.170336152942, 5995.640261584319, 5999.07014412758, 6002.579819412599, 6006.159137720722, 6398.584092034003, 6458.61248325102, 6511.28375878653, 6516.218053833571, 6527.51043671717, 5832.679202643895, 5980.73086711099, 5985.730642121115, 5985.940140598538, 5986.341502434729, 3490.8254587270535, 3530.064532898784, 3531.2231309111953, 3531.6291789362263, 3533.1520435095904, 6806.4554835613035, 6811.284815094443, 6812.046313516112, 6816.420604248595, 6820.454363650896, 6648.002799580005, 6659.2008958925235, 6660.23407308156, 6663.4669226461765, 6670.466362690973, 6688.264290927994, 6920.757773478005, 6951.756688515979, 6976.511644184859, 6978.79063628092, 6310.368963103653, 6504.349565043458, 6646.0, 6647.966760166169, 6650.102236198051, 6553.705083271169, 6583.80248592543, 6584.835379115369, 6585.440237579859, 6590.5716128451495, 6940.340667636567, 6946.861062778615, 6951.096357473496, 6953.895691564529, 6956.8956465652045, 4376.737395756265, 4450.955490445054, 4491.685582009228, 4518.525554816697, 4534.818607255673, 6608.933910660832, 6618.735250590115, 6628.5028622852515, 6628.83427914306, 6629.370209830058, 6466.224053113657, 6468.611883287018, 6473.611583305017, 6474.805755827333, 6478.1578394808375, 6265.185525881606, 6445.0, 6449.677516124269, 6495.0582165586675, 6500.349965003462, 6309.779157729457, 6334.556581039283, 6334.841628959313, 6335.334789847184, 6350.650714210763, 6520.18497687789, 6522.34776522344, 6525.869482610226, 6527.771527996498, 6529.118568993315, 6205.162303089025, 6357.442426605511, 6367.90448143269, 6372.267189273108, 6375.7449702013255], "unit": "score", "name": "prototype.html", "value": 4840.5086878124075}, {"lowerIsBetter": false, "replicates": [698.4377576051277, 722.7723267170841, 732.1104857598019, 813.9348852091833, 821.568676444866, 12644.367781610928, 12962.740745185103, 12983.0, 12994.610161695164, 13003.349832508373, 12171.695707607292, 12239.510419583206, 12242.510299588006, 12246.755064898696, 12257.938710306458, 663.0882536512296, 681.3016657925641, 797.6609940775162, 818.153211426174, 838.6393850644221, 821.256762629821, 827.611022819277, 830.1408042675831, 830.9667613295492, 832.0348395860802, 694.8228201808532, 864.0754392799707, 865.6148014133713, 866.376209129429, 866.6273502393999, 838.8909441772561, 853.8761879527434, 858.0947100808644, 858.716623514242, 861.8707193920899, 640.4844100499097, 641.5284765697209, 641.621443348422, 641.6727468990848, 641.6823672282203, 12174.452149653287, 12196.634100976986, 12224.2665440073, 12249.93875030628, 12322.81515777264, 11899.345535995517, 11906.523739050428, 12104.208018067813, 12309.753804923941, 12564.308963007032, 10229.64196253135, 10288.382697038202, 10350.171986241157, 10514.737131571772, 10641.467926603638, 4045.0898547826796, 4218.810153543098, 4225.619694227504, 4276.593723596254, 4287.249731297011, 48336.7583162089, 48547.514524855, 48843.755781221225, 48843.755781221225, 48944.510554894354, 9579.616815327308, 9803.558839852223, 10036.096751292418, 10250.641227557, 10259.384436933808, 16857.915710421614, 16866.915665421595, 16907.408240711517, 17376.65246695059, 17379.47861564155, 7412.962935185397, 7503.512271702322, 7517.887231691529, 7593.962030189814, 7741.729039483591, 4097.180563887235, 4173.269677806372, 4302.548232435612, 4346.826126954887, 4440.222960981815, 3092.8608212630484, 3125.8280794556517, 3126.2965832687464, 3131.2171957010746, 3142.7328677062706, 606.9575129740875, 607.134832863177, 610.255488304268, 628.5097623853402, 630.4389093706604, 604.5465900574569, 613.3467856732655, 628.6699482771581, 637.6333608175318, 666.8199586111723, 8111.594420278962, 8122.147174546706, 8199.590020498952, 8280.917190828135, 8583.289364964057, 488.182294656449, 518.7665550502289, 529.3013222546202, 537.2290762755381, 585.8740370820294, 3575.3028159508644, 3710.5361829771277, 3965.385365268388, 3995.081131339808, 4099.426080348753, 56680.71659641758, 56990.43009569934, 57006.429935700944, 57056.14415783767, 57122.14316785252, 51463.742681286356, 52082.47917520852, 52576.21135682968, 52589.737051315264, 52775.0, 44877.55122448734, 45366.0, 45577.54422455799, 45581.31628025582, 45765.542344576796, 7723.729669461766, 7960.124386317385, 8037.879431808645, 8138.104808471182, 8215.137410572042, 33624.49563256504, 33775.0, 34262.65737342694, 34354.82822585871, 34355.82822085873, 40577.0, 41774.0, 42504.57495425006, 44209.33685994777, 45112.77443612761, 10273.589056437659, 10317.9484102579, 10357.119644830274, 10392.48037598102, 10410.843837342294, 10836.241463097507, 10990.340579565252, 11105.278156919774, 11119.221654484432, 11197.944010279896, 10353.275270730977, 10558.577656893945, 10630.73423164427, 10644.308119972176, 10710.250282480152, 9919.206463483048, 10077.445740484343, 10107.343022703795, 10121.392716436743, 10143.188544916242, 10192.439415832201, 10467.0, 10469.738256543647, 10479.842802357818, 10603.310784798963, 8471.449355791854, 8557.445027013007, 8637.093105223861, 8739.868901966349, 8950.462972221687, 8494.872576911228, 8498.787530311793, 8689.478631282143, 8769.473831570127, 9264.629414823332], "unit": "score", "name": "yui.html", "value": 6103.518494438137}], "name": "dromaeo_css", "value": 6905.94506462758}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 106.0, 109.0, 110.0, 110.0, 98.0, 109.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 151.0, 172.0, 128.0, 149.0, 148.0, 135.0, 172.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 99.0, 108.0, 74.0, 74.0, 72.0, 119.0, 101.0, 79.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 96.0, 96.0, 96.0, 143.0, 95.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 59.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 114.0, 115.0, 127.0, 127.0, 119.0, 116.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 154.0, 158.0, 153.0, 147.0, 148.0, 154.0, 170.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [69.0, 73.0, 72.0, 69.0, 70.0, 67.0, 71.0, 74.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1519.2}]} 11:50:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6905.94"}}} 11:50:42 INFO - Return code: 0 11:50:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:50:43 INFO - # TBPL SUCCESS # 11:50:43 INFO - Running post-action listener: _resource_record_post_action 11:50:43 INFO - Running post-run listener: _resource_record_post_run 11:50:44 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 391274496; Read time: 0; Write time: 321640 11:50:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109088768; Read time: 0; Write time: 97100 11:50:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 282185728; Read time: 0; Write time: 224540 11:50:44 INFO - Running post-run listener: _upload_blobber_files 11:50:44 INFO - Blob upload gear active. 11:50:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:50:44 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:50:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:50:44 INFO - (blobuploader) - INFO - Open directory for files ... 11:50:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:50:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:45 INFO - (blobuploader) - INFO - Done attempting. 11:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:50:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:46 INFO - (blobuploader) - INFO - Done attempting. 11:50:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:50:46 INFO - Return code: 0 11:50:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:50:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:50:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de9e6b872533881d865171cf6a6cb66ecd4a197de515d186ec8c37627f4fedda70bc9cf43033f093da1d21c7a34dd402139a235e5b53ed0351a3d29eaa7d0e0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a049ddf0b5a189d96e274dd970bd111bc8a0e32f71c61c4d1c84eea45e98d35f546a15270b9118574a2fde4b8d57e6481fbc0dc4d53cf895da332c4fca003660"} 11:50:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:50:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:50:46 INFO - Contents: 11:50:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de9e6b872533881d865171cf6a6cb66ecd4a197de515d186ec8c37627f4fedda70bc9cf43033f093da1d21c7a34dd402139a235e5b53ed0351a3d29eaa7d0e0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a049ddf0b5a189d96e274dd970bd111bc8a0e32f71c61c4d1c84eea45e98d35f546a15270b9118574a2fde4b8d57e6481fbc0dc4d53cf895da332c4fca003660"} 11:50:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:50:46 INFO - Copying logs to upload dir... 11:50:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:50:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1309.061012 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-02-09 11:50:45.733982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 11:50:45.737287) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de9e6b872533881d865171cf6a6cb66ecd4a197de515d186ec8c37627f4fedda70bc9cf43033f093da1d21c7a34dd402139a235e5b53ed0351a3d29eaa7d0e0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a049ddf0b5a189d96e274dd970bd111bc8a0e32f71c61c4d1c84eea45e98d35f546a15270b9118574a2fde4b8d57e6481fbc0dc4d53cf895da332c4fca003660"} build_url:https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/LxoJB4fWS0WYlCjRH0TqfA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de9e6b872533881d865171cf6a6cb66ecd4a197de515d186ec8c37627f4fedda70bc9cf43033f093da1d21c7a34dd402139a235e5b53ed0351a3d29eaa7d0e0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a049ddf0b5a189d96e274dd970bd111bc8a0e32f71c61c4d1c84eea45e98d35f546a15270b9118574a2fde4b8d57e6481fbc0dc4d53cf895da332c4fca003660"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 11:50:45.764095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:50:45.764883) ========= 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=0274524eba3bdaad075c2247000001d4-1455045079.394755-1171077587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:50:45.850723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:50:45.851479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:50:45.852209) ========= ========= Total master_lag: 0.33 =========