builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1455033607.05 results: success (0) buildid: 20160209053003 builduid: 1fdfb2dfbe104830a2f22df77dd7003c revision: 683c1c3ca8321e064f7bcd2f690557ef6562bffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.054143) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.054589) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.054895) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.105535) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.105906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.151692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.152025) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.205846) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.206139) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.209545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.209848) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 08:00:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-02-09 08:00:07 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.323658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.323986) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022050 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.377177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.380652) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 683c1c3ca8321e064f7bcd2f690557ef6562bffb --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 683c1c3ca8321e064f7bcd2f690557ef6562bffb --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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 08:00:08,010 truncating revision to first 12 chars 2016-02-09 08:00:08,010 Setting DEBUG logging. 2016-02-09 08:00:08,010 attempt 1/10 2016-02-09 08:00:08,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/683c1c3ca832?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 08:00:08,336 unpacking tar archive at: fx-team-683c1c3ca832/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.998913) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:07.999258) ========= echo 683c1c3ca8321e064f7bcd2f690557ef6562bffb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'683c1c3ca8321e064f7bcd2f690557ef6562bffb'] 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 683c1c3ca8321e064f7bcd2f690557ef6562bffb program finished with exit code 0 elapsedTime=0.004493 script_repo_revision: '683c1c3ca8321e064f7bcd2f690557ef6562bffb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:08.054317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:08.057683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 08:00:08.083472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-09 08:00:08.083899) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:08 INFO - MultiFileLogger online at 20160209 08:00:08 in /builds/slave/test-pgo 08:00:08 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 08:00:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:00:08 INFO - {'append_to_log': False, 08:00:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:00:08 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:00:08 INFO - 'branch': 'Fx-Team', 08:00:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:08 INFO - 'config_files': ('talos/linux_config.py',), 08:00:08 INFO - 'default_actions': ('clobber', 08:00:08 INFO - 'read-buildbot-config', 08:00:08 INFO - 'download-and-extract', 08:00:08 INFO - 'populate-webroot', 08:00:08 INFO - 'create-virtualenv', 08:00:08 INFO - 'install', 08:00:08 INFO - 'run-tests'), 08:00:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:08 INFO - 'download_minidump_stackwalk': True, 08:00:08 INFO - 'download_symbols': 'ondemand', 08:00:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:08 INFO - 'installer_path': 'installer.exe', 08:00:08 INFO - 'log_level': 'info', 08:00:08 INFO - 'log_name': 'talos', 08:00:08 INFO - 'log_to_console': True, 08:00:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:08 INFO - 'opt_config_files': (), 08:00:08 INFO - 'pip_index': False, 08:00:08 INFO - 'sps_profile': False, 08:00:08 INFO - 'sps_profile_interval': 0, 08:00:08 INFO - 'suite': 'dromaeojs', 08:00:08 INFO - 'system_bits': '32', 08:00:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:08 INFO - 'title': 'talos-linux64-ix-012', 08:00:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:08 INFO - 'use_talos_json': True, 08:00:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:00:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:08 INFO - 'work_dir': 'build'} 08:00:08 INFO - ##### 08:00:08 INFO - ##### Running clobber step. 08:00:08 INFO - ##### 08:00:08 INFO - Running pre-action listener: _resource_record_pre_action 08:00:08 INFO - Running main action method: clobber 08:00:08 INFO - rmtree: /builds/slave/test-pgo/build 08:00:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:00:09 INFO - Running post-action listener: _resource_record_post_action 08:00:09 INFO - ##### 08:00:09 INFO - ##### Running read-buildbot-config step. 08:00:09 INFO - ##### 08:00:09 INFO - Running pre-action listener: _resource_record_pre_action 08:00:09 INFO - Running main action method: read_buildbot_config 08:00:09 INFO - Using buildbot properties: 08:00:09 INFO - { 08:00:09 INFO - "project": "", 08:00:09 INFO - "product": "firefox", 08:00:09 INFO - "script_repo_revision": "production", 08:00:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:09 INFO - "repository": "", 08:00:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:09 INFO - "buildid": "20160209053003", 08:00:09 INFO - "pgo_build": "True", 08:00:09 INFO - "basedir": "/builds/slave/test-pgo", 08:00:09 INFO - "buildnumber": 929, 08:00:09 INFO - "slavename": "talos-linux64-ix-012", 08:00:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:00:09 INFO - "platform": "ubuntu64_hw", 08:00:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:09 INFO - "branch": "fx-team", 08:00:09 INFO - "repo_path": "integration/fx-team", 08:00:09 INFO - "revision": "683c1c3ca8321e064f7bcd2f690557ef6562bffb", 08:00:09 INFO - "stage_platform": "linux64-pgo", 08:00:09 INFO - "builduid": "1fdfb2dfbe104830a2f22df77dd7003c", 08:00:09 INFO - "slavebuilddir": "test" 08:00:09 INFO - } 08:00:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:00:09 INFO - Running post-action listener: _resource_record_post_action 08:00:09 INFO - ##### 08:00:09 INFO - ##### Running download-and-extract step. 08:00:09 INFO - ##### 08:00:09 INFO - Running pre-action listener: _resource_record_pre_action 08:00:09 INFO - Running main action method: download_and_extract 08:00:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:09 INFO - https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/test_packages.json 08:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/test_packages.json 08:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:00:11 INFO - Downloaded 1448 bytes. 08:00:11 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:00:11 INFO - Using the following test package requirements: 08:00:11 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'jsshell-linux-x86_64.zip'], 08:00:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:11 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:11 INFO - https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:12 INFO - Downloaded 23290658 bytes. 08:00:12 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'] 08:00:12 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 08:00:13 INFO - Return code: 0 08:00:13 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 08:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:13 INFO - https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:17 INFO - Downloaded 23290658 bytes. 08:00:17 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'] 08:00:17 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 08:00:18 INFO - Return code: 0 08:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:18 INFO - https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:19 INFO - Downloaded 10706547 bytes. 08:00:19 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'] 08:00:19 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 08:00:19 INFO - Return code: 0 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:19 INFO - https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dJo6tXNeTDyDueCXQS3lPA/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 08:00:21 INFO - Downloaded 56548667 bytes. 08:00:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:21 INFO - mkdir: /builds/slave/test-pgo/properties 08:00:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:00:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:00:21 INFO - Contents: 08:00:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:22 INFO - Running post-action listener: _resource_record_post_action 08:00:22 INFO - Running post-action listener: set_extra_try_arguments 08:00:22 INFO - ##### 08:00:22 INFO - ##### Running populate-webroot step. 08:00:22 INFO - ##### 08:00:22 INFO - Running pre-action listener: _resource_record_pre_action 08:00:22 INFO - Running main action method: populate_webroot 08:00:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:22 INFO - '--tppagecycles', 08:00:22 INFO - '7'], 08:00:22 INFO - 'tests': ['tsvgm']}}, 08:00:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:00:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:00:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'tests': ['damp', 'tps']}, 08:00:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['damp', 'tps']}, 08:00:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:00:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:22 INFO - 'other': {'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'other_l64': {'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'other_nol64': {'tests': ['a11yr', 08:00:22 INFO - 'ts_paint', 08:00:22 INFO - 'tpaint', 08:00:22 INFO - 'sessionrestore', 08:00:22 INFO - 'sessionrestore_no_auto_restore']}, 08:00:22 INFO - 'svgr': {'tests': ['tsvgx', 08:00:22 INFO - 'tsvgr_opacity', 08:00:22 INFO - 'tart', 08:00:22 INFO - 'tscrollx', 08:00:22 INFO - 'cart']}, 08:00:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['tsvgx', 08:00:22 INFO - 'tsvgr_opacity', 08:00:22 INFO - 'tart', 08:00:22 INFO - 'tscrollx', 08:00:22 INFO - 'cart']}, 08:00:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'tests': ['tp5o']}, 08:00:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'talos_options': ['--e10s'], 08:00:22 INFO - 'tests': ['tp5o']}, 08:00:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'talos_options': ['--xperf_path', 08:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:22 INFO - 'tests': ['tp5n']}, 08:00:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:22 INFO - 'talos_options': ['--e10s', 08:00:22 INFO - '--xperf_path', 08:00:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:22 INFO - 'tests': ['tp5n']}}, 08:00:22 INFO - 'talos.zip': {'path': '', 08:00:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:22 INFO - Running post-action listener: _resource_record_post_action 08:00:22 INFO - ##### 08:00:22 INFO - ##### Running create-virtualenv step. 08:00:22 INFO - ##### 08:00:22 INFO - Running pre-action listener: _resource_record_pre_action 08:00:22 INFO - Running main action method: create_virtualenv 08:00:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:00:22 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 08:00:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:00:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:22 INFO - Using real prefix '/usr' 08:00:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:00:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:25 INFO - Installing pip.................done. 08:00:25 INFO - Return code: 0 08:00:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:00:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:00:25 INFO - Using env: {'DISPLAY': ':0', 08:00:25 INFO - 'HOME': '/home/cltbld', 08:00:25 INFO - 'LANG': 'en_US.UTF-8', 08:00:25 INFO - 'LANGUAGE': 'en_US:en', 08:00:25 INFO - 'LOGNAME': 'cltbld', 08:00:25 INFO - 'MAIL': '/var/mail/cltbld', 08:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:25 INFO - 'MOZ_NO_REMOTE': '1', 08:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:25 INFO - 'NO_EM_RESTART': '1', 08:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:25 INFO - 'SHELL': '/bin/bash', 08:00:25 INFO - 'SHLVL': '1', 08:00:25 INFO - 'TERM': 'linux', 08:00:25 INFO - 'TMOUT': '86400', 08:00:25 INFO - 'USER': 'cltbld', 08:00:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:25 INFO - '_': '/tools/buildbot/bin/python'} 08:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 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 08:00:25 INFO - Cleaning up... 08:00:25 INFO - Return code: 0 08:00:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:00:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:00:25 INFO - Using env: {'DISPLAY': ':0', 08:00:25 INFO - 'HOME': '/home/cltbld', 08:00:25 INFO - 'LANG': 'en_US.UTF-8', 08:00:25 INFO - 'LANGUAGE': 'en_US:en', 08:00:25 INFO - 'LOGNAME': 'cltbld', 08:00:25 INFO - 'MAIL': '/var/mail/cltbld', 08:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:25 INFO - 'MOZ_NO_REMOTE': '1', 08:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:25 INFO - 'NO_EM_RESTART': '1', 08:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:25 INFO - 'SHELL': '/bin/bash', 08:00:25 INFO - 'SHLVL': '1', 08:00:25 INFO - 'TERM': 'linux', 08:00:25 INFO - 'TMOUT': '86400', 08:00:25 INFO - 'USER': 'cltbld', 08:00:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:25 INFO - '_': '/tools/buildbot/bin/python'} 08:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 INFO - Downloading/unpacking psutil>=0.7.1 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:27 INFO - Installing collected packages: psutil 08:00:27 INFO - Running setup.py install for psutil 08:00:27 INFO - building 'psutil._psutil_linux' extension 08:00:27 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 08:00:27 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 08:00:27 INFO - building 'psutil._psutil_posix' extension 08:00:27 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 08:00:27 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 08:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:27 INFO - Successfully installed psutil 08:00:27 INFO - Cleaning up... 08:00:28 INFO - Return code: 0 08:00:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:28 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:28 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 08:00:28 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 08:00:28 INFO - Using env: {'DISPLAY': ':0', 08:00:28 INFO - 'HOME': '/home/cltbld', 08:00:28 INFO - 'LANG': 'en_US.UTF-8', 08:00:28 INFO - 'LANGUAGE': 'en_US:en', 08:00:28 INFO - 'LOGNAME': 'cltbld', 08:00:28 INFO - 'MAIL': '/var/mail/cltbld', 08:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:28 INFO - 'MOZ_NO_REMOTE': '1', 08:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:28 INFO - 'NO_EM_RESTART': '1', 08:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:28 INFO - 'SHELL': '/bin/bash', 08:00:28 INFO - 'SHLVL': '1', 08:00:28 INFO - 'TERM': 'linux', 08:00:28 INFO - 'TMOUT': '86400', 08:00:28 INFO - 'USER': 'cltbld', 08:00:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:28 INFO - '_': '/tools/buildbot/bin/python'} 08:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:28 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 08:00:28 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 08:00:28 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 08:00:28 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 08:00:28 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 08:00:28 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 08:00:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:30 INFO - Installing collected packages: mozsystemmonitor 08:00:30 INFO - Running setup.py install for mozsystemmonitor 08:00:30 INFO - Successfully installed mozsystemmonitor 08:00:30 INFO - Cleaning up... 08:00:30 INFO - Return code: 0 08:00:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:00:30 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')]} 08:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:30 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')]} 08:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:30 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:30 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 08:00:30 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 08:00:30 INFO - Using env: {'DISPLAY': ':0', 08:00:30 INFO - 'HOME': '/home/cltbld', 08:00:30 INFO - 'LANG': 'en_US.UTF-8', 08:00:30 INFO - 'LANGUAGE': 'en_US:en', 08:00:30 INFO - 'LOGNAME': 'cltbld', 08:00:30 INFO - 'MAIL': '/var/mail/cltbld', 08:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:30 INFO - 'MOZ_NO_REMOTE': '1', 08:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:30 INFO - 'NO_EM_RESTART': '1', 08:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:30 INFO - 'SHELL': '/bin/bash', 08:00:30 INFO - 'SHLVL': '1', 08:00:30 INFO - 'TERM': 'linux', 08:00:30 INFO - 'TMOUT': '86400', 08:00:30 INFO - 'USER': 'cltbld', 08:00:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:30 INFO - '_': '/tools/buildbot/bin/python'} 08:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:30 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 08:00:30 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 08:00:30 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 08:00:30 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 08:00:30 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 08:00:30 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 08:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 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 08:00:32 INFO - Downloading docopt-0.6.1.tar.gz 08:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:32 INFO - Running setup.py install for blobuploader 08:00:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:00:33 INFO - Running setup.py install for requests 08:00:33 INFO - Running setup.py install for docopt 08:00:33 INFO - Successfully installed blobuploader requests docopt 08:00:33 INFO - Cleaning up... 08:00:33 INFO - Return code: 0 08:00:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:33 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 08:00:33 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 08:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:33 INFO - Running setup.py (path:/tmp/pip-9wHI2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:33 INFO - Running setup.py (path:/tmp/pip-UPb4G9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:33 INFO - Running setup.py (path:/tmp/pip-V51kYg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:34 INFO - Running setup.py (path:/tmp/pip-fYA5uy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:34 INFO - Running setup.py (path:/tmp/pip-iiFOcA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:34 INFO - Running setup.py (path:/tmp/pip-yFDqu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:34 INFO - Running setup.py (path:/tmp/pip-AUfTQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:34 INFO - Running setup.py (path:/tmp/pip-pyrm5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:34 INFO - Running setup.py (path:/tmp/pip-dj4AIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:34 INFO - Running setup.py (path:/tmp/pip-bGj51g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:34 INFO - Running setup.py (path:/tmp/pip-qi7VDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:34 INFO - Running setup.py (path:/tmp/pip-kwZpo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:34 INFO - Running setup.py (path:/tmp/pip-HDEy93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:34 INFO - Running setup.py (path:/tmp/pip-iNezvT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:34 INFO - Running setup.py (path:/tmp/pip-_fogMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:34 INFO - Running setup.py (path:/tmp/pip-QZAF3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:34 INFO - Running setup.py (path:/tmp/pip-UX9uJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:35 INFO - Running setup.py install for manifestparser 08:00:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Running setup.py install for mozcrash 08:00:35 INFO - Running setup.py install for mozdebug 08:00:35 INFO - Running setup.py install for mozdevice 08:00:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Running setup.py install for mozfile 08:00:35 INFO - Running setup.py install for mozhttpd 08:00:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Running setup.py install for mozinfo 08:00:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Running setup.py install for mozInstall 08:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:00:35 INFO - Running setup.py install for mozleak 08:00:35 INFO - Running setup.py install for mozlog 08:00:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for moznetwork 08:00:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for mozprocess 08:00:36 INFO - Running setup.py install for mozprofile 08:00:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for mozrunner 08:00:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for mozscreenshot 08:00:36 INFO - Running setup.py install for moztest 08:00:36 INFO - Running setup.py install for mozversion 08:00:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:36 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')]} 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 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')]} 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:36 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 08:00:36 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 08:00:36 INFO - Using env: {'DISPLAY': ':0', 08:00:36 INFO - 'HOME': '/home/cltbld', 08:00:36 INFO - 'LANG': 'en_US.UTF-8', 08:00:36 INFO - 'LANGUAGE': 'en_US:en', 08:00:36 INFO - 'LOGNAME': 'cltbld', 08:00:36 INFO - 'MAIL': '/var/mail/cltbld', 08:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:36 INFO - 'MOZ_NO_REMOTE': '1', 08:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:36 INFO - 'NO_EM_RESTART': '1', 08:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:36 INFO - 'SHELL': '/bin/bash', 08:00:36 INFO - 'SHLVL': '1', 08:00:36 INFO - 'TERM': 'linux', 08:00:36 INFO - 'TMOUT': '86400', 08:00:36 INFO - 'USER': 'cltbld', 08:00:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:36 INFO - '_': '/tools/buildbot/bin/python'} 08:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:37 INFO - Running setup.py (path:/tmp/pip-kyzRw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:37 INFO - Running setup.py (path:/tmp/pip-mGtVQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:37 INFO - Running setup.py (path:/tmp/pip-dziVF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:37 INFO - Running setup.py (path:/tmp/pip-aTAf9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:37 INFO - Running setup.py (path:/tmp/pip-jdOPuI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:37 INFO - Running setup.py (path:/tmp/pip-wRnLU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:37 INFO - Running setup.py (path:/tmp/pip-_eXjP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:37 INFO - Running setup.py (path:/tmp/pip-AVg2yS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:37 INFO - Running setup.py (path:/tmp/pip-gJemHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:37 INFO - Running setup.py (path:/tmp/pip-ruJ1Dj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:37 INFO - Running setup.py (path:/tmp/pip-mkP85e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:37 INFO - Running setup.py (path:/tmp/pip-LFDICv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:37 INFO - Running setup.py (path:/tmp/pip-w1WP5O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:37 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)) 08:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:37 INFO - Running setup.py (path:/tmp/pip-yJ6VvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:38 INFO - Running setup.py (path:/tmp/pip-5m28Dy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:38 INFO - Running setup.py (path:/tmp/pip-OgTGkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:38 INFO - Running setup.py (path:/tmp/pip-rTIluz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:38 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)) 08:00:38 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)) 08:00:38 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)) 08:00:38 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)) 08:00:38 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)) 08:00:38 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)) 08:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:40 INFO - Downloading blessings-1.6.tar.gz 08:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:40 INFO - Installing collected packages: blessings 08:00:40 INFO - Running setup.py install for blessings 08:00:40 INFO - Successfully installed blessings 08:00:40 INFO - Cleaning up... 08:00:40 INFO - Return code: 0 08:00:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:40 INFO - Reading from file tmpfile_stdout 08:00:40 INFO - Current package versions: 08:00:40 INFO - argparse == 1.2.1 08:00:40 INFO - blessings == 1.6 08:00:40 INFO - blobuploader == 1.2.4 08:00:40 INFO - docopt == 0.6.1 08:00:40 INFO - manifestparser == 1.1 08:00:40 INFO - mozInstall == 1.12 08:00:40 INFO - mozcrash == 0.16 08:00:40 INFO - mozdebug == 0.1 08:00:40 INFO - mozdevice == 0.48 08:00:40 INFO - mozfile == 1.2 08:00:40 INFO - mozhttpd == 0.7 08:00:40 INFO - mozinfo == 0.9 08:00:40 INFO - mozleak == 0.1 08:00:40 INFO - mozlog == 3.1 08:00:40 INFO - moznetwork == 0.27 08:00:40 INFO - mozprocess == 0.22 08:00:40 INFO - mozprofile == 0.28 08:00:40 INFO - mozrunner == 6.11 08:00:40 INFO - mozscreenshot == 0.1 08:00:40 INFO - mozsystemmonitor == 0.0 08:00:40 INFO - moztest == 0.7 08:00:40 INFO - mozversion == 1.4 08:00:40 INFO - psutil == 3.1.1 08:00:40 INFO - requests == 1.2.3 08:00:40 INFO - wsgiref == 0.1.2 08:00:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:40 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')]} 08:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:40 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')]} 08:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:40 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:40 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 08:00:40 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 08:00:40 INFO - Using env: {'DISPLAY': ':0', 08:00:40 INFO - 'HOME': '/home/cltbld', 08:00:40 INFO - 'LANG': 'en_US.UTF-8', 08:00:40 INFO - 'LANGUAGE': 'en_US:en', 08:00:40 INFO - 'LOGNAME': 'cltbld', 08:00:40 INFO - 'MAIL': '/var/mail/cltbld', 08:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:40 INFO - 'MOZ_NO_REMOTE': '1', 08:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:40 INFO - 'NO_EM_RESTART': '1', 08:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:40 INFO - 'SHELL': '/bin/bash', 08:00:40 INFO - 'SHLVL': '1', 08:00:40 INFO - 'TERM': 'linux', 08:00:40 INFO - 'TMOUT': '86400', 08:00:40 INFO - 'USER': 'cltbld', 08:00:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:40 INFO - '_': '/tools/buildbot/bin/python'} 08:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 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)) 08:00:40 INFO - Cleaning up... 08:00:40 INFO - Return code: 0 08:00:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:00:40 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')]} 08:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:40 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')]} 08:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:40 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 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:40 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 08:00:40 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 08:00:40 INFO - Using env: {'DISPLAY': ':0', 08:00:40 INFO - 'HOME': '/home/cltbld', 08:00:40 INFO - 'LANG': 'en_US.UTF-8', 08:00:40 INFO - 'LANGUAGE': 'en_US:en', 08:00:40 INFO - 'LOGNAME': 'cltbld', 08:00:40 INFO - 'MAIL': '/var/mail/cltbld', 08:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:40 INFO - 'MOZ_NO_REMOTE': '1', 08:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:40 INFO - 'NO_EM_RESTART': '1', 08:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:40 INFO - 'SHELL': '/bin/bash', 08:00:40 INFO - 'SHLVL': '1', 08:00:40 INFO - 'TERM': 'linux', 08:00:40 INFO - 'TMOUT': '86400', 08:00:40 INFO - 'USER': 'cltbld', 08:00:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:40 INFO - '_': '/tools/buildbot/bin/python'} 08:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:40 INFO - Downloading/unpacking jsonschema 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:42 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:42 INFO - warning: no files found matching '*.txt' 08:00:42 INFO - no previously-included directories found matching 'build' 08:00:42 INFO - no previously-included directories found matching 'dist' 08:00:42 INFO - no previously-included directories found matching '.git*' 08:00:42 INFO - Installing collected packages: jsonschema, functools32 08:00:43 INFO - Running setup.py install for functools32 08:00:43 INFO - warning: no files found matching '*.txt' 08:00:43 INFO - no previously-included directories found matching 'build' 08:00:43 INFO - no previously-included directories found matching 'dist' 08:00:43 INFO - no previously-included directories found matching '.git*' 08:00:43 INFO - Successfully installed jsonschema functools32 08:00:43 INFO - Cleaning up... 08:00:43 INFO - Return code: 0 08:00:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d29fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', '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 08:00:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:00:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:00:43 INFO - Using env: {'DISPLAY': ':0', 08:00:43 INFO - 'HOME': '/home/cltbld', 08:00:43 INFO - 'LANG': 'en_US.UTF-8', 08:00:43 INFO - 'LANGUAGE': 'en_US:en', 08:00:43 INFO - 'LOGNAME': 'cltbld', 08:00:43 INFO - 'MAIL': '/var/mail/cltbld', 08:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:43 INFO - 'MOZ_NO_REMOTE': '1', 08:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:43 INFO - 'NO_EM_RESTART': '1', 08:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:43 INFO - 'SHELL': '/bin/bash', 08:00:43 INFO - 'SHLVL': '1', 08:00:43 INFO - 'TERM': 'linux', 08:00:43 INFO - 'TMOUT': '86400', 08:00:43 INFO - 'USER': 'cltbld', 08:00:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:43 INFO - '_': '/tools/buildbot/bin/python'} 08:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:43 INFO - Downloading/unpacking flake8 08:00:43 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 08:00:43 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 08:00:43 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 08:00:43 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 08:00:43 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 08:00:43 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 08:00:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:45 INFO - no previously-included directories found matching 'docs/_build' 08:00:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:45 INFO - Running setup.py install for pep8 08:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:46 INFO - no previously-included directories found matching 'docs/_build' 08:00:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:00:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:46 INFO - Cleaning up... 08:00:46 INFO - Return code: 0 08:00:46 INFO - Running post-action listener: _resource_record_post_action 08:00:46 INFO - Running post-action listener: _start_resource_monitoring 08:00:46 INFO - Starting resource monitoring. 08:00:46 INFO - ##### 08:00:46 INFO - ##### Running install step. 08:00:46 INFO - ##### 08:00:46 INFO - Running pre-action listener: _resource_record_pre_action 08:00:46 INFO - Running main action method: install 08:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:46 INFO - Reading from file tmpfile_stdout 08:00:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:00:46 INFO - Reading from file tmpfile_stdout 08:00:46 INFO - Output received: 08:00:46 INFO - Usage: mozinstall [options] installer 08:00:46 INFO - Options: 08:00:46 INFO - -h, --help show this help message and exit 08:00:46 INFO - -d DEST, --destination=DEST 08:00:46 INFO - Directory to install application into. [default: 08:00:46 INFO - "/builds/slave/test-pgo"] 08:00:46 INFO - --app=APP Application being installed. [default: firefox] 08:00:46 INFO - mkdir: /builds/slave/test-pgo/build/application 08:00:46 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'] 08:00:46 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 08:01:02 INFO - Reading from file tmpfile_stdout 08:01:02 INFO - Output received: 08:01:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:01:02 INFO - Running post-action listener: _resource_record_post_action 08:01:02 INFO - ##### 08:01:02 INFO - ##### Running run-tests step. 08:01:02 INFO - ##### 08:01:02 INFO - Running pre-action listener: _resource_record_pre_action 08:01:02 INFO - Running main action method: run_tests 08:01:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:01:02 INFO - Python 2.7.3 08:01:02 INFO - Return code: 0 08:01:02 INFO - grabbing minidump binary from tooltool 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 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 0xe788c0>, '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 0xe797c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe79c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:01:02 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 08:01:02 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 08:01:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:02 INFO - Return code: 0 08:01:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:01:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:01:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:01:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:01:03 INFO - Return code: 0 08:01:03 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/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:01:03 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/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 08:01:03 INFO - Using env: {'DISPLAY': ':0', 08:01:03 INFO - 'HOME': '/home/cltbld', 08:01:03 INFO - 'LANG': 'en_US.UTF-8', 08:01:03 INFO - 'LANGUAGE': 'en_US:en', 08:01:03 INFO - 'LOGNAME': 'cltbld', 08:01:03 INFO - 'MAIL': '/var/mail/cltbld', 08:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:03 INFO - 'MOZ_NO_REMOTE': '1', 08:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:03 INFO - 'NO_EM_RESTART': '1', 08:01:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:01:03 INFO - 'SHELL': '/bin/bash', 08:01:03 INFO - 'SHLVL': '1', 08:01:03 INFO - 'TERM': 'linux', 08:01:03 INFO - 'TMOUT': '86400', 08:01:03 INFO - 'USER': 'cltbld', 08:01:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040', 08:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:03 INFO - '_': '/tools/buildbot/bin/python'} 08:01:03 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/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:01:03 INFO - mozversion application_buildid: 20160209053003 08:01:03 INFO - mozversion application_changeset: 683c1c3ca8321e064f7bcd2f690557ef6562bffb 08:01:03 INFO - mozversion application_display_name: Nightly 08:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:03 INFO - mozversion application_name: Firefox 08:01:03 INFO - mozversion application_remotingname: firefox 08:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:03 INFO - mozversion application_vendor: Mozilla 08:01:03 INFO - mozversion application_version: 47.0a1 08:01:03 INFO - mozversion platform_buildid: 20160209053003 08:01:03 INFO - mozversion platform_changeset: 683c1c3ca8321e064f7bcd2f690557ef6562bffb 08:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:03 INFO - mozversion platform_version: 47.0a1 08:01:03 INFO - using testdate: 1455033663 08:01:03 INFO - actual date: 1455033663 08:01:03 INFO - starting webserver on 'localhost:41286' 08:01:03 INFO - SUITE-START | Running 2 tests 08:01:03 INFO - TEST-START | dromaeo_css 08:01:03 INFO - operating with platform_type : linux_ 08:01:03 INFO - Initialising browser for dromaeo_css test... 08:01:04 INFO - TEST-INFO | started process 14550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFH_pzn/profile http://localhost:41286/getInfo.html) 08:01:07 INFO - PROCESS | 14550 | __metrics Screen width/height:1600/1200 08:01:07 INFO - PROCESS | 14550 | colorDepth:24 08:01:07 INFO - PROCESS | 14550 | Browser inner width/height: 1024/697 08:01:07 INFO - PROCESS | 14550 | __metrics 08:01:07 INFO - PROCESS | 14550 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:08 INFO - TEST-INFO | 14550: exit 0 08:01:08 INFO - Browser initialized. 08:01:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:08 INFO - TEST-INFO | started process 14642 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFH_pzn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:20 INFO - PROCESS | 14642 | RSS: Main: 152293376 08:01:20 INFO - PROCESS | 14642 | 08:02:12 INFO - PROCESS | 14642 | 1455033732084 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] 08:04:20 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41286/tests/dromaeo/cssquery-ext.html) 08:04:21 INFO - PROCESS | 14642 | RSS: Main: 259682304 08:04:21 INFO - PROCESS | 14642 | 08:07:23 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-ext.html (next: http://localhost:41286/tests/dromaeo/cssquery-jquery.html) 08:07:24 INFO - PROCESS | 14642 | RSS: Main: 238391296 08:07:24 INFO - PROCESS | 14642 | 08:10:26 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41286/tests/dromaeo/cssquery-mootools.html) 08:10:26 INFO - PROCESS | 14642 | RSS: Main: 239476736 08:10:26 INFO - PROCESS | 14642 | 08:13:28 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41286/tests/dromaeo/cssquery-prototype.html) 08:13:29 INFO - PROCESS | 14642 | RSS: Main: 219009024 08:13:29 INFO - PROCESS | 14642 | 08:16:32 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41286/tests/dromaeo/cssquery-yui.html) 08:16:32 INFO - PROCESS | 14642 | RSS: Main: 221564928 08:16:32 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | Cycle 1(1): loaded http://localhost:41286/tests/dromaeo/cssquery-yui.html (next: http://localhost:41286/tests/dromaeo/cssquery-dojo.html) 08:19:35 INFO - PROCESS | 14642 | RSS: Main: 311816192 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | __start_tp_report 08:19:35 INFO - PROCESS | 14642 | _x_x_mozilla_page_load 08:19:35 INFO - PROCESS | 14642 | _x_x_mozilla_page_load_details 08:19:35 INFO - PROCESS | 14642 | |i|pagename|runs| 08:19:35 INFO - PROCESS | 14642 | |0;dojo.html;3059.2046068022314;3124.3751249750026;3155.3846999835027;3171.429142754305;3189.9362012759752;5133.743312834362;5168.534831865131;5172.741362931848;5203.063448579254;5265.789368425263;5163.483651634835;5249.816256431026;5266.052110620087;5314.840554783353;5316.840494785153;4754.263089221167;4758.333833263346;4897.461279259296;4927.359443272388;4952.554270115689;4740.241561350184;4885.5114488551035;4907.901841963158;4908.092002979442;4916.852494425173;4744.07490539345;4787.449443314029;4866.7566621668775;4883.169861123618;4907.828226012108;4757.048590281957;4764.547368000034;4768.451628062782;4773.66584339093;4805.495422980572;4634.86095417138;4759.381280433556;4765.070811191819;4786.042791441726;4796.232602783538;4999.200127979506;5104.106781313255;5105.719185444799;5110.591152707774;5146.6875946633745;5622.353429355636;5648.3222013358245;5652;5652.34997975234;5657.66054036755;5541.0580201365865;5609.775608975636;5625.353084395265;5670.064439367499;5691.032524470808;5243.947560524384;5266.605004624668;5276.34045744282;5277.525022747971;5297.020051290485;5719.914201286984;5737.168110624019;5754.964106460793;5761.8559536011935;5762.394948530427;5449.100898351728;5531.8893622128135;5538.0585300499015;5539.473749993744;5555.111182210827;5589.496945274945;5641.689707066069;5680.715964201773;5681.062624666966;5683.886322273532;5599.468050535193;5615.298087739033;5621.213030175779;5626.774929002794;5633.239512665819;5477.28795256622;5542.61201715876;5606.747696353674;5609.49514543693;5613.158026296007;4335.891602709958;4351.282038463682;4367.192069467159;4397.164538737629;4410.779461026936;3853.2871418787613;3864.42033694948;3874.4575759393706;3882.8835134946;3904.882853514399;5126.974365128225;5238.895222095537;5253.553447956967;5255.343082114736;5267.26258323835;5561.360443549043;5590.133529302964;5606.831795046155;5648.802291919763;5692.9146062809095;5242.004019236333;5256.553192978563;5267.815626453055;5276.918231762479;5292.259083728281;4657.115148121846;4742.383490146259;4871.220604703301;4878.9512104878495;4887.633427492952;5841.094630332305;5850.64896106235;5866.50134738552;5871.500922421642;5938.762449502058;5650.604457687922;5661.886762264649;5671.347795003628;5679.346875109415;5691;5712.057510510719;5743.253377060955;5797.159411885169;5857.853553661193;5858.091995740667;5482.122860342326;5498.147787093007;5499.972500137474;5502.972485137549;5507.366652834815;5582.720863956867;5628.74670639814;5659.094544872801;5674.57440691958;5681.602287839977;5470.179473078911;5519.8896022080135;5519.917201242065;5522.282103326542;5522.723863806874;5339.25250464943;5502.944970550243;5511;5535.861603459945;5537.778488860562;5283.39240987276;5339.866503337447;5351.759170837244;5383;5384.730763461889;5485.314335708036;5518.117101263779;5526.668399896019;5532;5537.418571049981;5323.547498462674;5376.516113549799;5409.513143817076;5418.593605479526;5422.132458806572 08:19:35 INFO - PROCESS | 14642 | |1;ext.html;533.8905524367502;534.922131904213;534.925110484532;549.6372394219816;556.1824118545736;28312.150635480943;35456.82271588645;36362;36495.08762280944;36526;38792.224155516946;39078.609213907854;39336.606633933654;39341.8032909835;39373;8343;8624.137586241357;8627.913720862774;8629.180227878342;8640.438371505863;8427.199416055464;8576.185262400062;8595.828083438328;8599.484030958163;8760.342974276922;8732.694355697551;8792.34057445691;8816.250618697386;8816.250618697419;8818.514981676006;8675;8683.826323473526;8692.087330830298;8698.217160455557;8752.124787521261;8530.146985301482;8661.783455413602;8675.045744968049;8679.522626255553;8692.739217823475;38615;38943;39004.804975975225;39336.21327573461;39373.60626393728;3260.739140868725;3310.536524886518;3316.535685004101;3362.1090411041096;3410.3520331137006;29538;29979.550306745416;30426.84786576053;30656.38687226243;30866.537001944987;3811.7712937223855;3836.8848934532007;3854.2869569129803;3896.0649444133487;3946.1515774108416;258389;259543;259832;260138;260239;49429.50570494321;50642;55935.16097258544;56138;56376.71811640915;53191.20213196805;53259;53307;53309.7334513325;53338;15380.154091525073;15614.687706245812;15625;15628.140452275007;15644.68710625781;10587.788244235073;12005.339706316061;12014.279143251433;12095.758084838253;12461.1900226485;17869.28522859071;18658.253669853326;18813.341533046278;18833.623327533373;18891.716624250646;7584.355329797029;7774.30031297186;7800.595892739361;7801.648925798353;7923.524588524707;993.4536005197257;1035.9896401035894;1111.4498323330004;1133.8491431197342;1141.8401423800674;29046.7095329044;29387.706122938926;29462.852685736863;29896;30084.699153008627;1143.9313641181557;1171.3206340322592;1179.33367647279;1211.5032836536977;1226.5523084074248;15393.307301171475;15607.921960390353;15630.3747850087;15829.841701582836;15955.760663590056;314526;318243;318375;318610;319100;51987.74006130021;52374.47625523772;52387.47612523902;52401;52435.21347179796;1349;1377.1943413103247;1381.1574939287027;1384.515419603151;1391.7634002219647;28618.284542886595;29027.274318142216;29141.271468213465;29397.11808645744;29760;45297.54702452933;45791.77104114458;45856.541434585226;45873.54126458693;45875.31187032264;269555;291981;294894;296510;299660;25915.740842592088;25966.480670386863;26012;26286.21141365762;26354.868225659517;40440.79779601083;41802.37296440617;41918.58081419147;42051.7897410511;42849.35725964051;32645.836770815993;32855.507167392985;33105;33216.50175247325;34277.314453710285;32250.838745806122;32691.34617307688;32863;32999.34001319912;33245.83377083196;33331.333373332884;33738.662613373555;34108;34220.82889585536;34224.14439639029;27282.181534553994;28209.294767630974;30244;30500.542491863085;30587.2353191172;23251.76748232496;26033;26166.4766704661;26425.846959843417;26633.63485617221 08:19:35 INFO - PROCESS | 14642 | |2;jquery.html;356.46174276841975;360.21652904931767;360.52230794197686;364.6353646353646;365.54672206463994;13452.93273533631;13687.3156342183;16108.75836862448;16907.49277521673;17976.280948762032;11129.944350278238;11385.772284554303;15124.470643527478;16469;16472.423465178723;4737.9763101184535;4851.951480485185;4870.099031679133;4872.415310162785;4876.366072410582;3789.2232092421127;4869.634777391692;4897.7795999180125;5256.737163141846;5463.945360546403;5416.404195538487;5417.51242388185;5473.781048758065;5485.0949593317055;5486.862828429281;5175.767090480918;5333.253344531769;5355.598330125217;5368.516833485005;5397.973010134963;4977.1538838397555;5094.949050509485;5132.923006154911;5157.432682404932;5160.664556803796;12123.33321667308;14031.64920876976;20096.497587560283;20240.291589794433;20292.695609565868;2134.5730853829295;2175.010370281518;2191.37545799448;2291;2652.562327216007;9107.681231156877;9314.627414903396;9362.578683959238;9516.619335226582;9796.412215267106;1797.5837544358005;1870.5510677437453;1879.1262063140568;1883.0867029490687;1907.4659095453296;57081.71459142719;59147.704261478415;59655;60960;62225;9548.42709437436;9998.350107243006;10250.794984100276;10329.276950613385;10419.635312764018;13617.038264236866;13636.93181534086;13840.723185536433;13868.514601988882;13893.513727019708;7667.539947603162;7721.112072111667;7722.961385193038;7732.110807257125;7767.650455729506;7442.776716698508;7474.1404738454685;7486.6256687166515;7503.287187717158;7537.133229678548;4502.580175072635;4504.684672072924;4508.1659892919915;4513.774311284488;4559.703619264737;1705.2070787084065;1731.1257814803696;1825.7626508553803;1872.410190789897;1876.587150826816;925.8287216864901;993.3642468819961;1056.9852941176557;1066.3228849680509;1076.5424694504804;15990.840091598935;16097.275622597012;16398.344066237456;16469.752953705705;17387.82612173862;919.7332773495611;927.8005228875824;960.1694534227843;967.4920666650065;1002.9448380339005;8856.38005339633;8953.820923581492;9027.50348730813;9040.909590904139;9231.446113233227;415650;439769;477405;482090;482130;73455.26544734591;74101.25898741052;74227.62886185535;75353;77011.61494192493;1043.2540733375672;1127.1546340244815;1151.7293436042523;1182.5920057580122;1198.7842188405996;10417.843732344172;10553.314034587727;14404.711905762035;14739.2630368479;15196.468123615621;32790.67209327972;34151.829240853636;34345;34353;38161.427578586896;35275.47086793752;43426.348604771585;43789.56210437855;44166.558334416244;48234.758826205645;9650.420974741539;9998.550065247227;10091.495425228855;10515.211359148247;10544.52549635253;11700.88299116998;11853.111016673956;11986.46060927243;12192.146549741434;12239.20445171061;10492;10681.946590266998;10827.036333235706;11010.449477526252;11121.27711698737;7059.894101588583;7933.1670174630835;7948.125706172201;10264.024917632813;10988.835167472334;7559.811004724926;7640.503367281109;7810.179931107152;7815.452918295892;7973.80065498344;9729.22166226686;9994.700158995242;10180.541875615763;10329.380237185793;10668.519916603927;10911.618093366695;11099.167562433011;11110.944445277722;11114;11181.664550063511 08:19:35 INFO - PROCESS | 14642 | |3;mootools.html;1275.470679667938;1458.5624312706188;1478.5564330700788;1646.382606522554;1821.307902996862;6862.245153033163;7383.667734951927;7518.7368442104535;7562.810929726759;7564.243575642433;7362.9631851840795;7558.62206889656;7564.130125035623;7566.886496702554;7573.091229052521;1987.9801201988012;2035.5827055453597;2206.1175529788134;2291.3927809130596;2315.189683610731;2316.548273086749;2324.8721320327377;2329.033451117784;2330.149495434171;2333.276684227886;2140.5076832328573;2197.3957161780477;2198;2199.6480563109903;2205.1399954017947;2279.931602051941;2286.702728645282;2289.416198869286;2341.028473183627;2341.683872677184;2209.1936443198115;2216.180013395054;2322.9419264518524;2343.847649902768;2350.8001819845335;7622.8475430491635;7693.576853273068;7704.768856934301;7711.5758633275145;7737.613119344067;4622.722636641779;4778.617710583145;4786.377770889762;4799.472058073609;4810.54299841518;3118.454270502653;3130.514770210621;3143.167060728909;3182;3213.1324542373427;1013.6198925402974;1033.168299518887;1037.3205550364523;1060.6923992042375;1072.7961687279392;10568.894311056867;10631.52158152885;10643.254972151952;10644.520996555173;10652.520636571373;4264.253755592759;4323.956760432356;4394.758288294111;4395.868123956287;4399.692021558524;9023.864642030374;9042.819143617091;9046.457212567268;9059.909400906039;9060.275177985744;4829.6860704054825;4839.225723884161;4840.322354870321;4846.709197448165;4866.099771542276;4418.403515525363;4425.513193548707;4431.357453169337;4453.621442177451;4454.532274111237;3343.465045592742;3580.445031020196;3603.56757189139;3621.149029977953;3650.634936506328;1150.3615493401076;1180.144395313408;1189.649053529211;1193.8985186259092;1203.771283456158;1334.1328136711215;1340.557615986722;1350.0482160077122;1367.9384427700777;1367.9658008549866;7041.366277035091;7192.604406757679;7297.014902988135;7398.96300518494;7419.888701669479;1122.2593088561673;1133.863936327646;1136.2273653915418;1159.1827761428174;1163.6567212672282;5183.81856635016;5214.45248248936;5229.163333866563;5236.423993360727;5243.659162154448;9065.365424420359;9078.137576930181;9501.382410143318;9565.665201717906;9584.424934503952;9467.952660236655;9468.573914173741;9474.242060635133;9476.289278304155;9482.620695172116;6936.132983377078;7107.538010029435;7130.215676275606;7310.4517161213125;7317.12194536659;7084.114485689289;7150.249223831423;7172.318629730167;7181.030560874216;7182.317679820409;8151.673933042612;8214.630341634522;8222.218889205516;8311.916880831115;8345.123762004901;8202.835943280981;8492.150784921458;8500.74497765068;8579.785505362415;8635.050144484227;6438.356164383524;6631.602103873783;6646.634435105922;6657.234418041987;6814.318568143146;6510.804675859732;6862.897056544056;7070.929290707027;7076.646167691698;7091.858162836817;6631.701573429304;6730.899036514358;6740.662966851736;6984.650767461505;7007.054047703698;6571.769988050395;6582.11141495911;6632.966835165793;6717.1267735194115;6758.594484330759;6794.898076528955;6841.828954276183;6847.589144651337;6901.827454313682;7030.367266945999;6291.685415729286;6389.434588525841;6409.230892292955;6444.8388790280615;6462.256840463218;6472.029195620695;6511.576747511396;6542.901856472062;6561.442277406474;6563.442107420923 08:19:35 INFO - PROCESS | 14642 | |4;prototype.html;335.20221871944767;336.89051058406017;341.49288306864304;342.18559827610284;348.7088281285125;5624.184493248476;5765.538756899448;5824.650520968739;5853.414658534144;5877.441643043915;5623.128415095667;5712.8857422851515;5746.798862039829;5748.798792042279;5752.453516915897;4531.818727250906;4538.773061346919;4541.227991241497;4550.908981820362;4562.817487300504;4349.7390156590545;4408.801603927831;4514.706544074625;4527.660425468087;4555;4492.39352687388;4504.977475112636;4512.210363186446;4516.209663308924;4521.977390113061;4482.574155455227;4508.5266047064915;4522.186006518826;4525.208088584517;4533;3996.6003399660094;3998.6001399859783;4002.4396584478195;4009.578994205596;4013.779242141681;5407.918881216785;5533.335999680024;5571.721413929328;5572;5574.665520068768;5138.922916156261;5142.871428214287;5145.945081258333;5147.305113809625;5150.407703114152;5870.882582348372;6155.538334624921;6174.289956654952;6183.721732522047;6196.597221180609;4360.956390436118;4451.554844515555;4460.397846290742;4463.910721785546;4465.598096171328;6211.534134939852;6399.872002559922;6401.295857455676;6413.070104834773;6419.743210271584;4488.663350248679;4489.640828733759;4492.034212644297;4496.955030449653;4497.797599108048;4477.485089214717;4553.3397657340165;4553.430821147356;4620.075984803053;4657.976710116428;5262.02652509287;5262.421133675292;5267.762950667229;5271.077561426735;5272.130098533699;6178.62928224308;6183.474404675563;6188.319284878659;6194.318624951252;6194.752209911643;1606.1326883482789;1615.5961009747564;1615.7899473068426;1616.2888329135144;1618.0372678256654;1105.2429086076063;1126.2791813239533;1137.3687603380038;1157.1841851494676;1162.4652659776598;5879.970600147058;5883.0293001654245;5885.764569417175;5888.705564721832;5890.558208134407;6370.044493325945;6407.551471396958;6448.226212854393;6451.032345148265;6457.031445283151;5872.647641141545;5874.148248504029;5885.264341957255;5885.764569417261;5888.028475301528;3361.9495707564406;3466.30673865228;3469.2020835208045;3473.0622731862254;3474.3746125697617;6635.701393437211;6643.833904152339;6688.498362622823;6691.79924602253;6693.933060669331;6575.671216439159;6578.243501997332;6583.736650533925;6584.572002819801;6593.80218593443;6529.053287273414;6651.135352404253;6653.2681405045405;6660.933390666031;6670.032845237511;6165.136880836776;6267.2479302484;6434.131392261985;6436.645984470899;6450.838729031624;6318.652474113968;6336.556441049082;6338.461230795434;6348.222497700651;6358.459530939737;6636.170478690164;6659.400653940975;6668.299828517936;6669.032990216295;6671.366220209073;4345.283028300295;4377.0808130291725;4389.4952080509875;4423.314386270134;4426.336049592587;6426.453751430994;6426.903596445964;6436.13112229843;6437.195350581177;6446.548741588043;6208.410201030895;6233.719482623384;6236.906446403217;6252.6865059926295;6268.968655156695;6113.969430152821;6238.282597501346;6239.1577137085915;6239.75040998355;6243.313235544178;6130.601510901777;6132.540059495466;6134.110553969738;6141.785037523844;6147.754089836535;6283;6289.433950944437;6291.874162516632;6294.748210071729;6300.936990630218;6000.459958603747;6137.631742095488;6140.938590614037;6148.9692551536955;6164.229471316085 08:19:35 INFO - PROCESS | 14642 | |5;yui.html;686.6360828760756;748.5957582905231;773.1147835728088;784.0630446616294;816.7917181118814;13041.67395815104;13243.867561324383;13248.867511324885;13252.668683282898;13255.270960097203;13068.411921463534;13125.803112953314;13132.868671313285;13133;13146.408411621476;663.8141320430287;677.0453660338923;822.284612387224;825.4551995682865;840.6427268410931;823.172711425017;827.9213474719892;828.0436096308773;829.0838623321233;832.4422636833336;705.5167210460825;881.8765372847806;886.3086792302015;886.5921676029035;889.4885440871492;722.7759394587695;854.5001174313003;880.423322723617;884.5621417398397;884.823035392924;653.464159389301;654.7741029344916;655.2562841175253;655.4232275597492;656.5338609587199;13584.388702508311;13614.251216183105;13648.522301719393;13657.863421365759;13669.658258543517;13066.477340906353;13392.799108013387;13433.798493022612;13442.260675662834;13471.932640336834;10308.948455257676;10582.974824729166;10624.415657138854;10776.892231077745;11219.831702524469;3673.1184515716304;3721.5720192177973;3738.9626103738888;3814.1036856338737;3816.141368192162;46094.76952615215;46578.30132548015;46618.30072548914;46637.30044049342;46667;9709.5145242739;9990.550425230882;10026.74933126663;10039.899601004043;10321.741956450998;18585.90707046456;18600.627987440446;18628.25486980533;18628.72056919147;18650.81349186491;7342.192358840523;7420.703171873172;7421.443391745533;7430.442716796262;7479.027726395534;3989.4813674222746;4086.5709100544013;4095.508538975342;4133.338665813455;4156;3144.6540880503126;3162.6362968258945;3180.904572862818;3182.220356012792;3192.8403579820915;542.6689719271242;553.1426289251724;556.5408537956203;565.2905603467622;571.0206995003589;574.9913751293734;630.1870586942792;663.4559661077869;711.207004190324;716.9533980291264;8657.307415406753;8724.045046567277;8771.254443372385;8878.422902511316;9004.459732416077;531.657081182635;534.5322842512801;554.431707499816;555.0647159536195;596.7314708381246;4191.895202619898;4201.810918508613;4256.29771087767;4371.388005679208;4380.987308022005;53036.204456932406;53476.732616337446;53971.19043214355;54137;54437.72781136148;47769.76115119402;48842.511574884506;48900.510994890305;49113.754431227615;49330.260046099334;42216;42747.145057098685;42973.14053718908;43246.13507729828;43660.99999999937;8168.180773343755;8234;8471.57642117904;8553.486790792573;8634.16375753723;32542.34915301728;32875.835620821745;34572.48141277933;35446.291074177854;35925.82037089798;41309.173816524104;41492.1701565961;41663.166736665706;41922;42239.788801055794;10760.19298552596;10988.395638239974;11423.485943132413;11443.75059182356;11607.941960290482;12089.637310880687;12333.814992775295;12459.252444853339;12676.176048556814;12834.229946203257;11075.446227688422;11109.333439993627;11199.944000279946;11577.479013444583;11774.705632359259;11042.33745975244;11275.379854108103;11513.769724605629;11521.711957201138;11612.825807612724;10897.346159230472;10969.177311701815;11068.446577671246;11363.261388009752;11952.282863028246;9145.314101442551;9424.434533927986;9430.52847357643;9751.951240243754;9762.121409073217;9193.632254710004;9326.440413575207;9716.271279653913;10066.798664026532;10203.897961020295 08:19:35 INFO - PROCESS | 14642 | __end_tp_report 08:19:35 INFO - PROCESS | 14642 | __start_cc_report 08:19:35 INFO - PROCESS | 14642 | _x_x_mozilla_cycle_collect,800 08:19:35 INFO - PROCESS | 14642 | __end_cc_report 08:19:35 INFO - PROCESS | 14642 | __startTimestamp1455034775428__endTimestamp 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | ------- Summary: start ------- 08:19:35 INFO - PROCESS | 14642 | Number of tests: 6 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#0] dojo.html Cycles:165 Average:5222.51 Median:5384.73 stddev:573.55 (10.7%) stddev-sans-first:549.63 08:19:35 INFO - PROCESS | 14642 | Values: 3059.2 3124.4 3155.4 3171.4 3189.9 5133.7 5168.5 5172.7 5203.1 5265.8 5163.5 5249.8 5266.1 5314.8 5316.8 4754.3 4758.3 4897.5 4927.4 4952.6 4740.2 4885.5 4907.9 4908.1 4916.9 4744.1 4787.4 4866.8 4883.2 4907.8 4757.0 4764.5 4768.5 4773.7 4805.5 4634.9 4759.4 4765.1 4786.0 4796.2 4999.2 5104.1 5105.7 5110.6 5146.7 5622.4 5648.3 5652.0 5652.3 5657.7 5541.1 5609.8 5625.4 5670.1 5691.0 5243.9 5266.6 5276.3 5277.5 5297.0 5719.9 5737.2 5755.0 5761.9 5762.4 5449.1 5531.9 5538.1 5539.5 5555.1 5589.5 5641.7 5680.7 5681.1 5683.9 5599.5 5615.3 5621.2 5626.8 5633.2 5477.3 5542.6 5606.7 5609.5 5613.2 4335.9 4351.3 4367.2 4397.2 4410.8 3853.3 3864.4 3874.5 3882.9 3904.9 5127.0 5238.9 5253.6 5255.3 5267.3 5561.4 5590.1 5606.8 5648.8 5692.9 5242.0 5256.6 5267.8 5276.9 5292.3 4657.1 4742.4 4871.2 4879.0 4887.6 5841.1 5850.6 5866.5 5871.5 5938.8 5650.6 5661.9 5671.3 5679.3 5691.0 5712.1 5743.3 5797.2 5857.9 5858.1 5482.1 5498.1 5500.0 5503.0 5507.4 5582.7 5628.7 5659.1 5674.6 5681.6 5470.2 5519.9 5519.9 5522.3 5522.7 5339.3 5502.9 5511.0 5535.9 5537.8 5283.4 5339.9 5351.8 5383.0 5384.7 5485.3 5518.1 5526.7 5532.0 5537.4 5323.5 5376.5 5409.5 5418.6 5422.1 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#1] ext.html Cycles:180 Average:45055.87 Median:33231.17 stddev:75862.28 (228.3%) stddev-sans-first:76001.44 08:19:35 INFO - PROCESS | 14642 | Values: 533.9 534.9 534.9 549.6 556.2 28312.2 35456.8 36362.0 36495.1 36526.0 38792.2 39078.6 39336.6 39341.8 39373.0 8343.0 8624.1 8627.9 8629.2 8640.4 8427.2 8576.2 8595.8 8599.5 8760.3 8732.7 8792.3 8816.3 8816.3 8818.5 8675.0 8683.8 8692.1 8698.2 8752.1 8530.1 8661.8 8675.0 8679.5 8692.7 38615.0 38943.0 39004.8 39336.2 39373.6 3260.7 3310.5 3316.5 3362.1 3410.4 29538.0 29979.6 30426.8 30656.4 30866.5 3811.8 3836.9 3854.3 3896.1 3946.2 258389.0 259543.0 259832.0 260138.0 260239.0 49429.5 50642.0 55935.2 56138.0 56376.7 53191.2 53259.0 53307.0 53309.7 53338.0 15380.2 15614.7 15625.0 15628.1 15644.7 10587.8 12005.3 12014.3 12095.8 12461.2 17869.3 18658.3 18813.3 18833.6 18891.7 7584.4 7774.3 7800.6 7801.6 7923.5 993.5 1036.0 1111.4 1133.8 1141.8 29046.7 29387.7 29462.9 29896.0 30084.7 1143.9 1171.3 1179.3 1211.5 1226.6 15393.3 15607.9 15630.4 15829.8 15955.8 314526.0 318243.0 318375.0 318610.0 319100.0 51987.7 52374.5 52387.5 52401.0 52435.2 1349.0 1377.2 1381.2 1384.5 1391.8 28618.3 29027.3 29141.3 29397.1 29760.0 45297.5 45791.8 45856.5 45873.5 45875.3 269555.0 291981.0 294894.0 296510.0 299660.0 25915.7 25966.5 26012.0 26286.2 26354.9 40440.8 41802.4 41918.6 42051.8 42849.4 32645.8 32855.5 33105.0 33216.5 34277.3 32250.8 32691.3 32863.0 32999.3 33245.8 33331.3 33738.7 34108.0 34220.8 34224.1 27282.2 28209.3 30244.0 30500.5 30587.2 23251.8 26033.0 26166.5 26425.8 26633.6 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#2] jquery.html Cycles:180 Average:25453.93 Median:20975.33 stddev:75378.20 (359.4%) stddev-sans-first:75566.09 08:19:35 INFO - PROCESS | 14642 | Values: 356.5 360.2 360.5 364.6 365.5 13452.9 13687.3 16108.8 16907.5 17976.3 11129.9 11385.8 15124.5 16469.0 16472.4 4738.0 4852.0 4870.1 4872.4 4876.4 3789.2 4869.6 4897.8 5256.7 5463.9 5416.4 5417.5 5473.8 5485.1 5486.9 5175.8 5333.3 5355.6 5368.5 5398.0 4977.2 5094.9 5132.9 5157.4 5160.7 12123.3 14031.6 20096.5 20240.3 20292.7 2134.6 2175.0 2191.4 2291.0 2652.6 9107.7 9314.6 9362.6 9516.6 9796.4 1797.6 1870.6 1879.1 1883.1 1907.5 57081.7 59147.7 59655.0 60960.0 62225.0 9548.4 9998.4 10250.8 10329.3 10419.6 13617.0 13636.9 13840.7 13868.5 13893.5 7667.5 7721.1 7723.0 7732.1 7767.7 7442.8 7474.1 7486.6 7503.3 7537.1 4502.6 4504.7 4508.2 4513.8 4559.7 1705.2 1731.1 1825.8 1872.4 1876.6 925.8 993.4 1057.0 1066.3 1076.5 15990.8 16097.3 16398.3 16469.8 17387.8 919.7 927.8 960.2 967.5 1002.9 8856.4 8953.8 9027.5 9040.9 9231.4 415650.0 439769.0 477405.0 482090.0 482130.0 73455.3 74101.3 74227.6 75353.0 77011.6 1043.3 1127.2 1151.7 1182.6 1198.8 10417.8 10553.3 14404.7 14739.3 15196.5 32790.7 34151.8 34345.0 34353.0 38161.4 35275.5 43426.3 43789.6 44166.6 48234.8 9650.4 9998.6 10091.5 10515.2 10544.5 11700.9 11853.1 11986.5 12192.1 12239.2 10492.0 10681.9 10827.0 11010.4 11121.3 7059.9 7933.2 7948.1 10264.0 10988.8 7559.8 7640.5 7810.2 7815.5 7973.8 9729.2 9994.7 10180.5 10329.4 10668.5 10911.6 11099.2 11110.9 11114.0 11181.7 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#3] mootools.html Cycles:180 Average:5392.71 Median:6340.56 stddev:2761.53 (43.6%) stddev-sans-first:2751.93 08:19:35 INFO - PROCESS | 14642 | Values: 1275.5 1458.6 1478.6 1646.4 1821.3 6862.2 7383.7 7518.7 7562.8 7564.2 7363.0 7558.6 7564.1 7566.9 7573.1 1988.0 2035.6 2206.1 2291.4 2315.2 2316.5 2324.9 2329.0 2330.1 2333.3 2140.5 2197.4 2198.0 2199.6 2205.1 2279.9 2286.7 2289.4 2341.0 2341.7 2209.2 2216.2 2322.9 2343.8 2350.8 7622.8 7693.6 7704.8 7711.6 7737.6 4622.7 4778.6 4786.4 4799.5 4810.5 3118.5 3130.5 3143.2 3182.0 3213.1 1013.6 1033.2 1037.3 1060.7 1072.8 10568.9 10631.5 10643.3 10644.5 10652.5 4264.3 4324.0 4394.8 4395.9 4399.7 9023.9 9042.8 9046.5 9059.9 9060.3 4829.7 4839.2 4840.3 4846.7 4866.1 4418.4 4425.5 4431.4 4453.6 4454.5 3343.5 3580.4 3603.6 3621.1 3650.6 1150.4 1180.1 1189.6 1193.9 1203.8 1334.1 1340.6 1350.0 1367.9 1368.0 7041.4 7192.6 7297.0 7399.0 7419.9 1122.3 1133.9 1136.2 1159.2 1163.7 5183.8 5214.5 5229.2 5236.4 5243.7 9065.4 9078.1 9501.4 9565.7 9584.4 9468.0 9468.6 9474.2 9476.3 9482.6 6936.1 7107.5 7130.2 7310.5 7317.1 7084.1 7150.2 7172.3 7181.0 7182.3 8151.7 8214.6 8222.2 8311.9 8345.1 8202.8 8492.2 8500.7 8579.8 8635.1 6438.4 6631.6 6646.6 6657.2 6814.3 6510.8 6862.9 7070.9 7076.6 7091.9 6631.7 6730.9 6740.7 6984.7 7007.1 6571.8 6582.1 6633.0 6717.1 6758.6 6794.9 6841.8 6847.6 6901.8 7030.4 6291.7 6389.4 6409.2 6444.8 6462.3 6472.0 6511.6 6542.9 6561.4 6563.4 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#4] prototype.html Cycles:180 Average:5207.70 Median:5873.40 stddev:1544.15 (26.3%) stddev-sans-first:1504.55 08:19:35 INFO - PROCESS | 14642 | Values: 335.2 336.9 341.5 342.2 348.7 5624.2 5765.5 5824.7 5853.4 5877.4 5623.1 5712.9 5746.8 5748.8 5752.5 4531.8 4538.8 4541.2 4550.9 4562.8 4349.7 4408.8 4514.7 4527.7 4555.0 4492.4 4505.0 4512.2 4516.2 4522.0 4482.6 4508.5 4522.2 4525.2 4533.0 3996.6 3998.6 4002.4 4009.6 4013.8 5407.9 5533.3 5571.7 5572.0 5574.7 5138.9 5142.9 5145.9 5147.3 5150.4 5870.9 6155.5 6174.3 6183.7 6196.6 4361.0 4451.6 4460.4 4463.9 4465.6 6211.5 6399.9 6401.3 6413.1 6419.7 4488.7 4489.6 4492.0 4497.0 4497.8 4477.5 4553.3 4553.4 4620.1 4658.0 5262.0 5262.4 5267.8 5271.1 5272.1 6178.6 6183.5 6188.3 6194.3 6194.8 1606.1 1615.6 1615.8 1616.3 1618.0 1105.2 1126.3 1137.4 1157.2 1162.5 5880.0 5883.0 5885.8 5888.7 5890.6 6370.0 6407.6 6448.2 6451.0 6457.0 5872.6 5874.1 5885.3 5885.8 5888.0 3361.9 3466.3 3469.2 3473.1 3474.4 6635.7 6643.8 6688.5 6691.8 6693.9 6575.7 6578.2 6583.7 6584.6 6593.8 6529.1 6651.1 6653.3 6660.9 6670.0 6165.1 6267.2 6434.1 6436.6 6450.8 6318.7 6336.6 6338.5 6348.2 6358.5 6636.2 6659.4 6668.3 6669.0 6671.4 4345.3 4377.1 4389.5 4423.3 4426.3 6426.5 6426.9 6436.1 6437.2 6446.5 6208.4 6233.7 6236.9 6252.7 6269.0 6114.0 6238.3 6239.2 6239.8 6243.3 6130.6 6132.5 6134.1 6141.8 6147.8 6283.0 6289.4 6291.9 6294.7 6300.9 6000.5 6137.6 6140.9 6149.0 6164.2 08:19:35 INFO - PROCESS | 14642 | 08:19:35 INFO - PROCESS | 14642 | [#5] yui.html Cycles:180 Average:13446.85 Median:43109.64 stddev:15030.85 (34.9%) stddev-sans-first:15042.46 08:19:35 INFO - PROCESS | 14642 | Values: 686.6 748.6 773.1 784.1 816.8 13041.7 13243.9 13248.9 13252.7 13255.3 13068.4 13125.8 13132.9 13133.0 13146.4 663.8 677.0 822.3 825.5 840.6 823.2 827.9 828.0 829.1 832.4 705.5 881.9 886.3 886.6 889.5 722.8 854.5 880.4 884.6 884.8 653.5 654.8 655.3 655.4 656.5 13584.4 13614.3 13648.5 13657.9 13669.7 13066.5 13392.8 13433.8 13442.3 13471.9 10308.9 10583.0 10624.4 10776.9 11219.8 3673.1 3721.6 3739.0 3814.1 3816.1 46094.8 46578.3 46618.3 46637.3 46667.0 9709.5 9990.6 10026.7 10039.9 10321.7 18585.9 18600.6 18628.3 18628.7 18650.8 7342.2 7420.7 7421.4 7430.4 7479.0 3989.5 4086.6 4095.5 4133.3 4156.0 3144.7 3162.6 3180.9 3182.2 3192.8 542.7 553.1 556.5 565.3 571.0 575.0 630.2 663.5 711.2 717.0 8657.3 8724.0 8771.3 8878.4 9004.5 531.7 534.5 554.4 555.1 596.7 4191.9 4201.8 4256.3 4371.4 4381.0 53036.2 53476.7 53971.2 54137.0 54437.7 47769.8 48842.5 48900.5 49113.8 49330.3 42216.0 42747.1 42973.1 43246.1 43661.0 8168.2 8234.0 8471.6 8553.5 8634.2 32542.3 32875.8 34572.5 35446.3 35925.8 41309.2 41492.2 41663.2 41922.0 42239.8 10760.2 10988.4 11423.5 11443.8 11607.9 12089.6 12333.8 12459.3 12676.2 12834.2 11075.4 11109.3 11199.9 11577.5 11774.7 11042.3 11275.4 11513.8 11521.7 11612.8 10897.3 10969.2 11068.4 11363.3 11952.3 9145.3 9424.4 9430.5 9752.0 9762.1 9193.6 9326.4 9716.3 10066.8 10203.9 08:19:35 INFO - PROCESS | 14642 | -------- Summary: end -------- 08:19:35 INFO - PROCESS | 14642 | 08:19:36 INFO - TEST-INFO | 14642: exit 0 08:19:36 INFO - TEST-OK | dromaeo_css | took 1112136ms 08:19:36 INFO - TEST-START | kraken 08:19:36 INFO - operating with platform_type : linux_ 08:19:36 INFO - Initialising browser for kraken test... 08:19:36 INFO - TEST-INFO | started process 14834 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4b52ls/profile http://localhost:41286/getInfo.html) 08:19:39 INFO - PROCESS | 14834 | __metrics Screen width/height:1600/1200 08:19:39 INFO - PROCESS | 14834 | colorDepth:24 08:19:39 INFO - PROCESS | 14834 | Browser inner width/height: 1024/697 08:19:39 INFO - PROCESS | 14834 | __metrics 08:19:39 INFO - PROCESS | 14834 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:40 INFO - TEST-INFO | 14834: exit 0 08:19:40 INFO - Browser initialized. 08:19:40 INFO - Running cycle 1/1 for kraken test... 08:19:40 INFO - TEST-INFO | started process 14917 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4b52ls/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:52 INFO - PROCESS | 14917 | RSS: Main: 151605248 08:19:52 INFO - PROCESS | 14917 | 08:19:54 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41286/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:55 INFO - PROCESS | 14917 | RSS: Main: 191795200 08:19:55 INFO - PROCESS | 14917 | 08:19:58 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41286/tests/kraken/driver.html?testName=audio-dft) 08:19:58 INFO - PROCESS | 14917 | RSS: Main: 180695040 08:19:58 INFO - PROCESS | 14917 | 08:20:01 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41286/tests/kraken/driver.html?testName=audio-fft) 08:20:02 INFO - PROCESS | 14917 | RSS: Main: 167657472 08:20:02 INFO - PROCESS | 14917 | 08:20:04 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41286/tests/kraken/driver.html?testName=audio-oscillator) 08:20:04 INFO - PROCESS | 14917 | RSS: Main: 168091648 08:20:04 INFO - PROCESS | 14917 | 08:20:07 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:07 INFO - PROCESS | 14917 | RSS: Main: 169762816 08:20:07 INFO - PROCESS | 14917 | 08:20:10 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41286/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:11 INFO - PROCESS | 14917 | RSS: Main: 171790336 08:20:11 INFO - PROCESS | 14917 | 08:20:14 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41286/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:15 INFO - PROCESS | 14917 | RSS: Main: 170995712 08:20:15 INFO - PROCESS | 14917 | 08:20:17 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41286/tests/kraken/driver.html?testName=json-parse-financial) 08:20:18 INFO - PROCESS | 14917 | RSS: Main: 170823680 08:20:18 INFO - PROCESS | 14917 | 08:20:20 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:20 INFO - PROCESS | 14917 | RSS: Main: 181350400 08:20:20 INFO - PROCESS | 14917 | 08:20:22 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:23 INFO - PROCESS | 14917 | RSS: Main: 178053120 08:20:23 INFO - PROCESS | 14917 | 08:20:25 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:25 INFO - PROCESS | 14917 | RSS: Main: 189419520 08:20:25 INFO - PROCESS | 14917 | 08:20:28 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:28 INFO - PROCESS | 14917 | RSS: Main: 194854912 08:20:28 INFO - PROCESS | 14917 | 08:20:31 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:32 INFO - PROCESS | 14917 | RSS: Main: 193236992 08:20:32 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | Cycle 1(1): loaded http://localhost:41286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41286/tests/kraken/driver.html?testName=ai-astar) 08:20:33 INFO - PROCESS | 14917 | RSS: Main: 253124608 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | __start_tp_report 08:20:33 INFO - PROCESS | 14917 | _x_x_mozilla_page_load 08:20:33 INFO - PROCESS | 14917 | _x_x_mozilla_page_load_details 08:20:33 INFO - PROCESS | 14917 | |i|pagename|runs| 08:20:33 INFO - PROCESS | 14917 | |0;ai-astar;109;112;107;112;112;115;104;112;110;110 08:20:33 INFO - PROCESS | 14917 | |1;audio-beat-detection;152;130;148;162;128;152;161;131;165;126 08:20:33 INFO - PROCESS | 14917 | |2;audio-dft;162;161;161;160;163;163;160;163;160;161 08:20:33 INFO - PROCESS | 14917 | |3;audio-fft;76;73;99;94;73;77;73;115;98;72 08:20:33 INFO - PROCESS | 14917 | |4;audio-oscillator;96;95;145;96;95;96;149;95;95;138 08:20:33 INFO - PROCESS | 14917 | |5;imaging-gaussian-blur;119;115;114;115;115;115;114;115;115;115 08:20:33 INFO - PROCESS | 14917 | |6;imaging-darkroom;145;146;145;145;146;145;145;146;145;145 08:20:33 INFO - PROCESS | 14917 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 08:20:33 INFO - PROCESS | 14917 | |8;json-parse-financial;56;57;56;56;56;57;56;65;55;55 08:20:33 INFO - PROCESS | 14917 | |9;json-stringify-tinderbox;68;68;68;68;68;68;68;67;68;67 08:20:33 INFO - PROCESS | 14917 | |10;stanford-crypto-aes;90;86;87;85;87;86;92;86;85;84 08:20:33 INFO - PROCESS | 14917 | |11;stanford-crypto-ccm;115;114;123;130;116;117;116;123;116;116 08:20:33 INFO - PROCESS | 14917 | |12;stanford-crypto-pbkdf2;157;145;156;151;144;143;165;156;163;153 08:20:33 INFO - PROCESS | 14917 | |13;stanford-crypto-sha256-iterative;70;68;70;69;69;68;68;73;67;68 08:20:33 INFO - PROCESS | 14917 | __end_tp_report 08:20:33 INFO - PROCESS | 14917 | __start_cc_report 08:20:33 INFO - PROCESS | 14917 | _x_x_mozilla_cycle_collect,970 08:20:33 INFO - PROCESS | 14917 | __end_cc_report 08:20:33 INFO - PROCESS | 14917 | __startTimestamp1455034833965__endTimestamp 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | ------- Summary: start ------- 08:20:33 INFO - PROCESS | 14917 | Number of tests: 14 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.09 (2.8%) stddev-sans-first:3.24 08:20:33 INFO - PROCESS | 14917 | Values: 109.0 112.0 107.0 112.0 112.0 115.0 104.0 112.0 110.0 110.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.00 stddev:15.35 (10.1%) stddev-sans-first:16.10 08:20:33 INFO - PROCESS | 14917 | Values: 152.0 130.0 148.0 162.0 128.0 152.0 161.0 131.0 165.0 126.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 08:20:33 INFO - PROCESS | 14917 | Values: 162.0 161.0 161.0 160.0 163.0 163.0 160.0 163.0 160.0 161.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.50 stddev:15.25 (19.9%) stddev-sans-first:15.82 08:20:33 INFO - PROCESS | 14917 | Values: 76.0 73.0 99.0 94.0 73.0 77.0 73.0 115.0 98.0 72.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:23.61 (24.9%) stddev-sans-first:24.50 08:20:33 INFO - PROCESS | 14917 | Values: 96.0 95.0 145.0 96.0 95.0 96.0 149.0 95.0 95.0 138.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:0.44 08:20:33 INFO - PROCESS | 14917 | Values: 119.0 115.0 114.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:20:33 INFO - PROCESS | 14917 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:20:33 INFO - PROCESS | 14917 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:2.92 (5.2%) stddev-sans-first:3.08 08:20:33 INFO - PROCESS | 14917 | Values: 56.0 57.0 56.0 56.0 56.0 57.0 56.0 65.0 55.0 55.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:20:33 INFO - PROCESS | 14917 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 67.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:2.44 (2.8%) stddev-sans-first:2.30 08:20:33 INFO - PROCESS | 14917 | Values: 90.0 86.0 87.0 85.0 87.0 86.0 92.0 86.0 85.0 84.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:116.50 stddev:5.08 (4.4%) stddev-sans-first:5.22 08:20:33 INFO - PROCESS | 14917 | Values: 115.0 114.0 123.0 130.0 116.0 117.0 116.0 123.0 116.0 116.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:156.00 stddev:7.65 (4.9%) stddev-sans-first:7.99 08:20:33 INFO - PROCESS | 14917 | Values: 157.0 145.0 156.0 151.0 144.0 143.0 165.0 156.0 163.0 153.0 08:20:33 INFO - PROCESS | 14917 | 08:20:33 INFO - PROCESS | 14917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.76 08:20:33 INFO - PROCESS | 14917 | Values: 70.0 68.0 70.0 69.0 69.0 68.0 68.0 73.0 67.0 68.0 08:20:33 INFO - PROCESS | 14917 | -------- Summary: end -------- 08:20:33 INFO - PROCESS | 14917 | 08:20:34 INFO - TEST-INFO | 14917: exit 0 08:20:34 INFO - TEST-OK | kraken | took 58756ms 08:20:34 INFO - SUITE-END | took 1170s 08:20:35 INFO - Completed test suite (00:19:31) 08:20:35 INFO - Working with test: dromaeo_css 08:20:35 INFO - Generating results file: dromaeo_css 08:20:35 INFO - Working with test: kraken 08:20:35 INFO - Generating results file: kraken 08:20:35 INFO - javascript benchmark 08:20:35 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:20:35 INFO - process_Request line: dromaeo_css 6831.08 graph.html#tests=[[72,64,35]] 08:20:35 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:35 INFO - process_Request line: kraken 1521.00 graph.html#tests=[[232,64,35]] 08:20:35 INFO - RETURN: dromaeo_css: 6831.08 08:20:35 INFO - RETURN: kraken: 1521.00 08:20:35 INFO - javascript benchmark 08:20:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3059.2046068022314, 3124.3751249750026, 3155.3846999835027, 3171.429142754305, 3189.9362012759752, 5133.743312834362, 5168.534831865131, 5172.741362931848, 5203.063448579254, 5265.789368425263, 5163.483651634835, 5249.816256431026, 5266.052110620087, 5314.840554783353, 5316.840494785153, 4754.263089221167, 4758.333833263346, 4897.461279259296, 4927.359443272388, 4952.554270115689, 4740.241561350184, 4885.5114488551035, 4907.901841963158, 4908.092002979442, 4916.852494425173, 4744.07490539345, 4787.449443314029, 4866.7566621668775, 4883.169861123618, 4907.828226012108, 4757.048590281957, 4764.547368000034, 4768.451628062782, 4773.66584339093, 4805.495422980572, 4634.86095417138, 4759.381280433556, 4765.070811191819, 4786.042791441726, 4796.232602783538, 4999.200127979506, 5104.106781313255, 5105.719185444799, 5110.591152707774, 5146.6875946633745, 5622.353429355636, 5648.3222013358245, 5652.0, 5652.34997975234, 5657.66054036755, 5541.0580201365865, 5609.775608975636, 5625.353084395265, 5670.064439367499, 5691.032524470808, 5243.947560524384, 5266.605004624668, 5276.34045744282, 5277.525022747971, 5297.020051290485, 5719.914201286984, 5737.168110624019, 5754.964106460793, 5761.8559536011935, 5762.394948530427, 5449.100898351728, 5531.8893622128135, 5538.0585300499015, 5539.473749993744, 5555.111182210827, 5589.496945274945, 5641.689707066069, 5680.715964201773, 5681.062624666966, 5683.886322273532, 5599.468050535193, 5615.298087739033, 5621.213030175779, 5626.774929002794, 5633.239512665819, 5477.28795256622, 5542.61201715876, 5606.747696353674, 5609.49514543693, 5613.158026296007, 4335.891602709958, 4351.282038463682, 4367.192069467159, 4397.164538737629, 4410.779461026936, 3853.2871418787613, 3864.42033694948, 3874.4575759393706, 3882.8835134946, 3904.882853514399, 5126.974365128225, 5238.895222095537, 5253.553447956967, 5255.343082114736, 5267.26258323835, 5561.360443549043, 5590.133529302964, 5606.831795046155, 5648.802291919763, 5692.9146062809095, 5242.004019236333, 5256.553192978563, 5267.815626453055, 5276.918231762479, 5292.259083728281, 4657.115148121846, 4742.383490146259, 4871.220604703301, 4878.9512104878495, 4887.633427492952, 5841.094630332305, 5850.64896106235, 5866.50134738552, 5871.500922421642, 5938.762449502058, 5650.604457687922, 5661.886762264649, 5671.347795003628, 5679.346875109415, 5691.0, 5712.057510510719, 5743.253377060955, 5797.159411885169, 5857.853553661193, 5858.091995740667, 5482.122860342326, 5498.147787093007, 5499.972500137474, 5502.972485137549, 5507.366652834815, 5582.720863956867, 5628.74670639814, 5659.094544872801, 5674.57440691958, 5681.602287839977, 5470.179473078911, 5519.8896022080135, 5519.917201242065, 5522.282103326542, 5522.723863806874, 5339.25250464943, 5502.944970550243, 5511.0, 5535.861603459945, 5537.778488860562, 5283.39240987276, 5339.866503337447, 5351.759170837244, 5383.0, 5384.730763461889, 5485.314335708036, 5518.117101263779, 5526.668399896019, 5532.0, 5537.418571049981, 5323.547498462674, 5376.516113549799, 5409.513143817076, 5418.593605479526, 5422.132458806572], "unit": "score", "name": "dojo.html", "value": 5185.610735775686}, {"lowerIsBetter": false, "replicates": [533.8905524367502, 534.922131904213, 534.925110484532, 549.6372394219816, 556.1824118545736, 28312.150635480943, 35456.82271588645, 36362.0, 36495.08762280944, 36526.0, 38792.224155516946, 39078.609213907854, 39336.606633933654, 39341.8032909835, 39373.0, 8343.0, 8624.137586241357, 8627.913720862774, 8629.180227878342, 8640.438371505863, 8427.199416055464, 8576.185262400062, 8595.828083438328, 8599.484030958163, 8760.342974276922, 8732.694355697551, 8792.34057445691, 8816.250618697386, 8816.250618697419, 8818.514981676006, 8675.0, 8683.826323473526, 8692.087330830298, 8698.217160455557, 8752.124787521261, 8530.146985301482, 8661.783455413602, 8675.045744968049, 8679.522626255553, 8692.739217823475, 38615.0, 38943.0, 39004.804975975225, 39336.21327573461, 39373.60626393728, 3260.739140868725, 3310.536524886518, 3316.535685004101, 3362.1090411041096, 3410.3520331137006, 29538.0, 29979.550306745416, 30426.84786576053, 30656.38687226243, 30866.537001944987, 3811.7712937223855, 3836.8848934532007, 3854.2869569129803, 3896.0649444133487, 3946.1515774108416, 258389.0, 259543.0, 259832.0, 260138.0, 260239.0, 49429.50570494321, 50642.0, 55935.16097258544, 56138.0, 56376.71811640915, 53191.20213196805, 53259.0, 53307.0, 53309.7334513325, 53338.0, 15380.154091525073, 15614.687706245812, 15625.0, 15628.140452275007, 15644.68710625781, 10587.788244235073, 12005.339706316061, 12014.279143251433, 12095.758084838253, 12461.1900226485, 17869.28522859071, 18658.253669853326, 18813.341533046278, 18833.623327533373, 18891.716624250646, 7584.355329797029, 7774.30031297186, 7800.595892739361, 7801.648925798353, 7923.524588524707, 993.4536005197257, 1035.9896401035894, 1111.4498323330004, 1133.8491431197342, 1141.8401423800674, 29046.7095329044, 29387.706122938926, 29462.852685736863, 29896.0, 30084.699153008627, 1143.9313641181557, 1171.3206340322592, 1179.33367647279, 1211.5032836536977, 1226.5523084074248, 15393.307301171475, 15607.921960390353, 15630.3747850087, 15829.841701582836, 15955.760663590056, 314526.0, 318243.0, 318375.0, 318610.0, 319100.0, 51987.74006130021, 52374.47625523772, 52387.47612523902, 52401.0, 52435.21347179796, 1349.0, 1377.1943413103247, 1381.1574939287027, 1384.515419603151, 1391.7634002219647, 28618.284542886595, 29027.274318142216, 29141.271468213465, 29397.11808645744, 29760.0, 45297.54702452933, 45791.77104114458, 45856.541434585226, 45873.54126458693, 45875.31187032264, 269555.0, 291981.0, 294894.0, 296510.0, 299660.0, 25915.740842592088, 25966.480670386863, 26012.0, 26286.21141365762, 26354.868225659517, 40440.79779601083, 41802.37296440617, 41918.58081419147, 42051.7897410511, 42849.35725964051, 32645.836770815993, 32855.507167392985, 33105.0, 33216.50175247325, 34277.314453710285, 32250.838745806122, 32691.34617307688, 32863.0, 32999.34001319912, 33245.83377083196, 33331.333373332884, 33738.662613373555, 34108.0, 34220.82889585536, 34224.14439639029, 27282.181534553994, 28209.294767630974, 30244.0, 30500.542491863085, 30587.2353191172, 23251.76748232496, 26033.0, 26166.4766704661, 26425.846959843417, 26633.63485617221], "unit": "score", "name": "ext.html", "value": 18062.822607319184}, {"lowerIsBetter": false, "replicates": [356.46174276841975, 360.21652904931767, 360.52230794197686, 364.6353646353646, 365.54672206463994, 13452.93273533631, 13687.3156342183, 16108.75836862448, 16907.49277521673, 17976.280948762032, 11129.944350278238, 11385.772284554303, 15124.470643527478, 16469.0, 16472.423465178723, 4737.9763101184535, 4851.951480485185, 4870.099031679133, 4872.415310162785, 4876.366072410582, 3789.2232092421127, 4869.634777391692, 4897.7795999180125, 5256.737163141846, 5463.945360546403, 5416.404195538487, 5417.51242388185, 5473.781048758065, 5485.0949593317055, 5486.862828429281, 5175.767090480918, 5333.253344531769, 5355.598330125217, 5368.516833485005, 5397.973010134963, 4977.1538838397555, 5094.949050509485, 5132.923006154911, 5157.432682404932, 5160.664556803796, 12123.33321667308, 14031.64920876976, 20096.497587560283, 20240.291589794433, 20292.695609565868, 2134.5730853829295, 2175.010370281518, 2191.37545799448, 2291.0, 2652.562327216007, 9107.681231156877, 9314.627414903396, 9362.578683959238, 9516.619335226582, 9796.412215267106, 1797.5837544358005, 1870.5510677437453, 1879.1262063140568, 1883.0867029490687, 1907.4659095453296, 57081.71459142719, 59147.704261478415, 59655.0, 60960.0, 62225.0, 9548.42709437436, 9998.350107243006, 10250.794984100276, 10329.276950613385, 10419.635312764018, 13617.038264236866, 13636.93181534086, 13840.723185536433, 13868.514601988882, 13893.513727019708, 7667.539947603162, 7721.112072111667, 7722.961385193038, 7732.110807257125, 7767.650455729506, 7442.776716698508, 7474.1404738454685, 7486.6256687166515, 7503.287187717158, 7537.133229678548, 4502.580175072635, 4504.684672072924, 4508.1659892919915, 4513.774311284488, 4559.703619264737, 1705.2070787084065, 1731.1257814803696, 1825.7626508553803, 1872.410190789897, 1876.587150826816, 925.8287216864901, 993.3642468819961, 1056.9852941176557, 1066.3228849680509, 1076.5424694504804, 15990.840091598935, 16097.275622597012, 16398.344066237456, 16469.752953705705, 17387.82612173862, 919.7332773495611, 927.8005228875824, 960.1694534227843, 967.4920666650065, 1002.9448380339005, 8856.38005339633, 8953.820923581492, 9027.50348730813, 9040.909590904139, 9231.446113233227, 415650.0, 439769.0, 477405.0, 482090.0, 482130.0, 73455.26544734591, 74101.25898741052, 74227.62886185535, 75353.0, 77011.61494192493, 1043.2540733375672, 1127.1546340244815, 1151.7293436042523, 1182.5920057580122, 1198.7842188405996, 10417.843732344172, 10553.314034587727, 14404.711905762035, 14739.2630368479, 15196.468123615621, 32790.67209327972, 34151.829240853636, 34345.0, 34353.0, 38161.427578586896, 35275.47086793752, 43426.348604771585, 43789.56210437855, 44166.558334416244, 48234.758826205645, 9650.420974741539, 9998.550065247227, 10091.495425228855, 10515.211359148247, 10544.52549635253, 11700.88299116998, 11853.111016673956, 11986.46060927243, 12192.146549741434, 12239.20445171061, 10492.0, 10681.946590266998, 10827.036333235706, 11010.449477526252, 11121.27711698737, 7059.894101588583, 7933.1670174630835, 7948.125706172201, 10264.024917632813, 10988.835167472334, 7559.811004724926, 7640.503367281109, 7810.179931107152, 7815.452918295892, 7973.80065498344, 9729.22166226686, 9994.700158995242, 10180.541875615763, 10329.380237185793, 10668.519916603927, 10911.618093366695, 11099.167562433011, 11110.944445277722, 11114.0, 11181.664550063511], "unit": "score", "name": "jquery.html", "value": 8222.317173269743}, {"lowerIsBetter": false, "replicates": [1275.470679667938, 1458.5624312706188, 1478.5564330700788, 1646.382606522554, 1821.307902996862, 6862.245153033163, 7383.667734951927, 7518.7368442104535, 7562.810929726759, 7564.243575642433, 7362.9631851840795, 7558.62206889656, 7564.130125035623, 7566.886496702554, 7573.091229052521, 1987.9801201988012, 2035.5827055453597, 2206.1175529788134, 2291.3927809130596, 2315.189683610731, 2316.548273086749, 2324.8721320327377, 2329.033451117784, 2330.149495434171, 2333.276684227886, 2140.5076832328573, 2197.3957161780477, 2198.0, 2199.6480563109903, 2205.1399954017947, 2279.931602051941, 2286.702728645282, 2289.416198869286, 2341.028473183627, 2341.683872677184, 2209.1936443198115, 2216.180013395054, 2322.9419264518524, 2343.847649902768, 2350.8001819845335, 7622.8475430491635, 7693.576853273068, 7704.768856934301, 7711.5758633275145, 7737.613119344067, 4622.722636641779, 4778.617710583145, 4786.377770889762, 4799.472058073609, 4810.54299841518, 3118.454270502653, 3130.514770210621, 3143.167060728909, 3182.0, 3213.1324542373427, 1013.6198925402974, 1033.168299518887, 1037.3205550364523, 1060.6923992042375, 1072.7961687279392, 10568.894311056867, 10631.52158152885, 10643.254972151952, 10644.520996555173, 10652.520636571373, 4264.253755592759, 4323.956760432356, 4394.758288294111, 4395.868123956287, 4399.692021558524, 9023.864642030374, 9042.819143617091, 9046.457212567268, 9059.909400906039, 9060.275177985744, 4829.6860704054825, 4839.225723884161, 4840.322354870321, 4846.709197448165, 4866.099771542276, 4418.403515525363, 4425.513193548707, 4431.357453169337, 4453.621442177451, 4454.532274111237, 3343.465045592742, 3580.445031020196, 3603.56757189139, 3621.149029977953, 3650.634936506328, 1150.3615493401076, 1180.144395313408, 1189.649053529211, 1193.8985186259092, 1203.771283456158, 1334.1328136711215, 1340.557615986722, 1350.0482160077122, 1367.9384427700777, 1367.9658008549866, 7041.366277035091, 7192.604406757679, 7297.014902988135, 7398.96300518494, 7419.888701669479, 1122.2593088561673, 1133.863936327646, 1136.2273653915418, 1159.1827761428174, 1163.6567212672282, 5183.81856635016, 5214.45248248936, 5229.163333866563, 5236.423993360727, 5243.659162154448, 9065.365424420359, 9078.137576930181, 9501.382410143318, 9565.665201717906, 9584.424934503952, 9467.952660236655, 9468.573914173741, 9474.242060635133, 9476.289278304155, 9482.620695172116, 6936.132983377078, 7107.538010029435, 7130.215676275606, 7310.4517161213125, 7317.12194536659, 7084.114485689289, 7150.249223831423, 7172.318629730167, 7181.030560874216, 7182.317679820409, 8151.673933042612, 8214.630341634522, 8222.218889205516, 8311.916880831115, 8345.123762004901, 8202.835943280981, 8492.150784921458, 8500.74497765068, 8579.785505362415, 8635.050144484227, 6438.356164383524, 6631.602103873783, 6646.634435105922, 6657.234418041987, 6814.318568143146, 6510.804675859732, 6862.897056544056, 7070.929290707027, 7076.646167691698, 7091.858162836817, 6631.701573429304, 6730.899036514358, 6740.662966851736, 6984.650767461505, 7007.054047703698, 6571.769988050395, 6582.11141495911, 6632.966835165793, 6717.1267735194115, 6758.594484330759, 6794.898076528955, 6841.828954276183, 6847.589144651337, 6901.827454313682, 7030.367266945999, 6291.685415729286, 6389.434588525841, 6409.230892292955, 6444.8388790280615, 6462.256840463218, 6472.029195620695, 6511.576747511396, 6542.901856472062, 6561.442277406474, 6563.442107420923], "unit": "score", "name": "mootools.html", "value": 4468.645329704344}, {"lowerIsBetter": false, "replicates": [335.20221871944767, 336.89051058406017, 341.49288306864304, 342.18559827610284, 348.7088281285125, 5624.184493248476, 5765.538756899448, 5824.650520968739, 5853.414658534144, 5877.441643043915, 5623.128415095667, 5712.8857422851515, 5746.798862039829, 5748.798792042279, 5752.453516915897, 4531.818727250906, 4538.773061346919, 4541.227991241497, 4550.908981820362, 4562.817487300504, 4349.7390156590545, 4408.801603927831, 4514.706544074625, 4527.660425468087, 4555.0, 4492.39352687388, 4504.977475112636, 4512.210363186446, 4516.209663308924, 4521.977390113061, 4482.574155455227, 4508.5266047064915, 4522.186006518826, 4525.208088584517, 4533.0, 3996.6003399660094, 3998.6001399859783, 4002.4396584478195, 4009.578994205596, 4013.779242141681, 5407.918881216785, 5533.335999680024, 5571.721413929328, 5572.0, 5574.665520068768, 5138.922916156261, 5142.871428214287, 5145.945081258333, 5147.305113809625, 5150.407703114152, 5870.882582348372, 6155.538334624921, 6174.289956654952, 6183.721732522047, 6196.597221180609, 4360.956390436118, 4451.554844515555, 4460.397846290742, 4463.910721785546, 4465.598096171328, 6211.534134939852, 6399.872002559922, 6401.295857455676, 6413.070104834773, 6419.743210271584, 4488.663350248679, 4489.640828733759, 4492.034212644297, 4496.955030449653, 4497.797599108048, 4477.485089214717, 4553.3397657340165, 4553.430821147356, 4620.075984803053, 4657.976710116428, 5262.02652509287, 5262.421133675292, 5267.762950667229, 5271.077561426735, 5272.130098533699, 6178.62928224308, 6183.474404675563, 6188.319284878659, 6194.318624951252, 6194.752209911643, 1606.1326883482789, 1615.5961009747564, 1615.7899473068426, 1616.2888329135144, 1618.0372678256654, 1105.2429086076063, 1126.2791813239533, 1137.3687603380038, 1157.1841851494676, 1162.4652659776598, 5879.970600147058, 5883.0293001654245, 5885.764569417175, 5888.705564721832, 5890.558208134407, 6370.044493325945, 6407.551471396958, 6448.226212854393, 6451.032345148265, 6457.031445283151, 5872.647641141545, 5874.148248504029, 5885.264341957255, 5885.764569417261, 5888.028475301528, 3361.9495707564406, 3466.30673865228, 3469.2020835208045, 3473.0622731862254, 3474.3746125697617, 6635.701393437211, 6643.833904152339, 6688.498362622823, 6691.79924602253, 6693.933060669331, 6575.671216439159, 6578.243501997332, 6583.736650533925, 6584.572002819801, 6593.80218593443, 6529.053287273414, 6651.135352404253, 6653.2681405045405, 6660.933390666031, 6670.032845237511, 6165.136880836776, 6267.2479302484, 6434.131392261985, 6436.645984470899, 6450.838729031624, 6318.652474113968, 6336.556441049082, 6338.461230795434, 6348.222497700651, 6358.459530939737, 6636.170478690164, 6659.400653940975, 6668.299828517936, 6669.032990216295, 6671.366220209073, 4345.283028300295, 4377.0808130291725, 4389.4952080509875, 4423.314386270134, 4426.336049592587, 6426.453751430994, 6426.903596445964, 6436.13112229843, 6437.195350581177, 6446.548741588043, 6208.410201030895, 6233.719482623384, 6236.906446403217, 6252.6865059926295, 6268.968655156695, 6113.969430152821, 6238.282597501346, 6239.1577137085915, 6239.75040998355, 6243.313235544178, 6130.601510901777, 6132.540059495466, 6134.110553969738, 6141.785037523844, 6147.754089836535, 6283.0, 6289.433950944437, 6291.874162516632, 6294.748210071729, 6300.936990630218, 6000.459958603747, 6137.631742095488, 6140.938590614037, 6148.9692551536955, 6164.229471316085], "unit": "score", "name": "prototype.html", "value": 4715.168172330281}, {"lowerIsBetter": false, "replicates": [686.6360828760756, 748.5957582905231, 773.1147835728088, 784.0630446616294, 816.7917181118814, 13041.67395815104, 13243.867561324383, 13248.867511324885, 13252.668683282898, 13255.270960097203, 13068.411921463534, 13125.803112953314, 13132.868671313285, 13133.0, 13146.408411621476, 663.8141320430287, 677.0453660338923, 822.284612387224, 825.4551995682865, 840.6427268410931, 823.172711425017, 827.9213474719892, 828.0436096308773, 829.0838623321233, 832.4422636833336, 705.5167210460825, 881.8765372847806, 886.3086792302015, 886.5921676029035, 889.4885440871492, 722.7759394587695, 854.5001174313003, 880.423322723617, 884.5621417398397, 884.823035392924, 653.464159389301, 654.7741029344916, 655.2562841175253, 655.4232275597492, 656.5338609587199, 13584.388702508311, 13614.251216183105, 13648.522301719393, 13657.863421365759, 13669.658258543517, 13066.477340906353, 13392.799108013387, 13433.798493022612, 13442.260675662834, 13471.932640336834, 10308.948455257676, 10582.974824729166, 10624.415657138854, 10776.892231077745, 11219.831702524469, 3673.1184515716304, 3721.5720192177973, 3738.9626103738888, 3814.1036856338737, 3816.141368192162, 46094.76952615215, 46578.30132548015, 46618.30072548914, 46637.30044049342, 46667.0, 9709.5145242739, 9990.550425230882, 10026.74933126663, 10039.899601004043, 10321.741956450998, 18585.90707046456, 18600.627987440446, 18628.25486980533, 18628.72056919147, 18650.81349186491, 7342.192358840523, 7420.703171873172, 7421.443391745533, 7430.442716796262, 7479.027726395534, 3989.4813674222746, 4086.5709100544013, 4095.508538975342, 4133.338665813455, 4156.0, 3144.6540880503126, 3162.6362968258945, 3180.904572862818, 3182.220356012792, 3192.8403579820915, 542.6689719271242, 553.1426289251724, 556.5408537956203, 565.2905603467622, 571.0206995003589, 574.9913751293734, 630.1870586942792, 663.4559661077869, 711.207004190324, 716.9533980291264, 8657.307415406753, 8724.045046567277, 8771.254443372385, 8878.422902511316, 9004.459732416077, 531.657081182635, 534.5322842512801, 554.431707499816, 555.0647159536195, 596.7314708381246, 4191.895202619898, 4201.810918508613, 4256.29771087767, 4371.388005679208, 4380.987308022005, 53036.204456932406, 53476.732616337446, 53971.19043214355, 54137.0, 54437.72781136148, 47769.76115119402, 48842.511574884506, 48900.510994890305, 49113.754431227615, 49330.260046099334, 42216.0, 42747.145057098685, 42973.14053718908, 43246.13507729828, 43660.99999999937, 8168.180773343755, 8234.0, 8471.57642117904, 8553.486790792573, 8634.16375753723, 32542.34915301728, 32875.835620821745, 34572.48141277933, 35446.291074177854, 35925.82037089798, 41309.173816524104, 41492.1701565961, 41663.166736665706, 41922.0, 42239.788801055794, 10760.19298552596, 10988.395638239974, 11423.485943132413, 11443.75059182356, 11607.941960290482, 12089.637310880687, 12333.814992775295, 12459.252444853339, 12676.176048556814, 12834.229946203257, 11075.446227688422, 11109.333439993627, 11199.944000279946, 11577.479013444583, 11774.705632359259, 11042.33745975244, 11275.379854108103, 11513.769724605629, 11521.711957201138, 11612.825807612724, 10897.346159230472, 10969.177311701815, 11068.446577671246, 11363.261388009752, 11952.282863028246, 9145.314101442551, 9424.434533927986, 9430.52847357643, 9751.951240243754, 9762.121409073217, 9193.632254710004, 9326.440413575207, 9716.271279653913, 10066.798664026532, 10203.897961020295], "unit": "score", "name": "yui.html", "value": 6261.0415654586795}], "name": "dromaeo_css", "value": 6831.082593526355}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 112.0, 112.0, 115.0, 104.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 148.0, 162.0, 128.0, 152.0, 161.0, 131.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 163.0, 163.0, 160.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 99.0, 94.0, 73.0, 77.0, 73.0, 115.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 145.0, 96.0, 95.0, 96.0, 149.0, 95.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 87.0, 85.0, 87.0, 86.0, 92.0, 86.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 123.0, 130.0, 116.0, 117.0, 116.0, 123.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [157.0, 145.0, 156.0, 151.0, 144.0, 143.0, 165.0, 156.0, 163.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 70.0, 69.0, 69.0, 68.0, 68.0, 73.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1520.9999999999998}]} 08:20:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6831.08"}}} 08:20:35 INFO - Return code: 0 08:20:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:35 INFO - # TBPL SUCCESS # 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - Running post-run listener: _resource_record_post_run 08:20:36 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 541032448; Read time: 0; Write time: 513892 08:20:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252248064; Read time: 0; Write time: 323672 08:20:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 288784384; Read time: 0; Write time: 190220 08:20:36 INFO - Running post-run listener: _upload_blobber_files 08:20:36 INFO - Blob upload gear active. 08:20:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:20:36 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 08:20:36 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'] 08:20:36 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 08:20:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:37 INFO - (blobuploader) - INFO - Done attempting. 08:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:38 INFO - (blobuploader) - INFO - Done attempting. 08:20:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:38 INFO - Return code: 0 08:20:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:20:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a45af921398ff66a87e34ddced70749a1275b3dc2d0e0ac047dcc388ed20503900fd736787803b2352cb1eb5403bf5033b18a1bb71de09557aeb9cf0eea89c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52974e204ff522b9808631ee617935408848bb3e06233640d28d17ded481a786b1be1db613614804dee708445f79d4f548076cd3345a35e27809c5b170e574f4"} 08:20:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:20:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:20:38 INFO - Contents: 08:20:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a45af921398ff66a87e34ddced70749a1275b3dc2d0e0ac047dcc388ed20503900fd736787803b2352cb1eb5403bf5033b18a1bb71de09557aeb9cf0eea89c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52974e204ff522b9808631ee617935408848bb3e06233640d28d17ded481a786b1be1db613614804dee708445f79d4f548076cd3345a35e27809c5b170e574f4"} 08:20:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:38 INFO - Copying logs to upload dir... 08:20:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:20:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.983329 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-09 08:20:38.100984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 08:20:38.105282) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 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/7a45af921398ff66a87e34ddced70749a1275b3dc2d0e0ac047dcc388ed20503900fd736787803b2352cb1eb5403bf5033b18a1bb71de09557aeb9cf0eea89c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52974e204ff522b9808631ee617935408848bb3e06233640d28d17ded481a786b1be1db613614804dee708445f79d4f548076cd3345a35e27809c5b170e574f4"} build_url:https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011524 build_url: 'https://queue.taskcluster.net/v1/task/dJo6tXNeTDyDueCXQS3lPA/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/7a45af921398ff66a87e34ddced70749a1275b3dc2d0e0ac047dcc388ed20503900fd736787803b2352cb1eb5403bf5033b18a1bb71de09557aeb9cf0eea89c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52974e204ff522b9808631ee617935408848bb3e06233640d28d17ded481a786b1be1db613614804dee708445f79d4f548076cd3345a35e27809c5b170e574f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 08:20:38.135465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:20:38.135845) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455033497.486537-1298073040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:20:38.222023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 08:20:38.222425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 08:20:38.222841) ========= ========= Total master_lag: 0.33 =========