builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1458788980.9 results: success (0) buildid: 20160323173027 builduid: 960c1cb2ea02476696a7b04e6e357fe3 revision: b999fac0569d760e971b6579c420eb887d645433 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.897081) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.897503) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.897801) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006442 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.936310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.936576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.958190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:40.958442) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.006953) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.007215) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.007548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.007833) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 20:09:41-- 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% 46.0M=0s 2016-03-23 20:09:41 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.175497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.175789) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016017 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.225194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.225523) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b999fac0569d760e971b6579c420eb887d645433 --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 b999fac0569d760e971b6579c420eb887d645433 --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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 20:09:41,981 truncating revision to first 12 chars 2016-03-23 20:09:41,981 Setting DEBUG logging. 2016-03-23 20:09:41,981 attempt 1/10 2016-03-23 20:09:41,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b999fac0569d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 20:09:42,228 unpacking tar archive at: fx-team-b999fac0569d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.761681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.762019) ========= echo b999fac0569d760e971b6579c420eb887d645433 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b999fac0569d760e971b6579c420eb887d645433'] 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b999fac0569d760e971b6579c420eb887d645433 program finished with exit code 0 elapsedTime=0.005007 script_repo_revision: 'b999fac0569d760e971b6579c420eb887d645433' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.811947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.812232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 20:09:41.822126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-23 20:09:41.822411) ========= /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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:42 INFO - MultiFileLogger online at 20160323 20:09:42 in /builds/slave/test-pgo 20:09:42 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 20:09:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:09:42 INFO - {'append_to_log': False, 20:09:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:09:42 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:09:42 INFO - 'branch': 'Fx-Team', 20:09:42 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:42 INFO - 'config_files': ('talos/linux_config.py',), 20:09:42 INFO - 'default_actions': ('clobber', 20:09:42 INFO - 'read-buildbot-config', 20:09:42 INFO - 'download-and-extract', 20:09:42 INFO - 'populate-webroot', 20:09:42 INFO - 'create-virtualenv', 20:09:42 INFO - 'install', 20:09:42 INFO - 'run-tests'), 20:09:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:42 INFO - 'download_minidump_stackwalk': True, 20:09:42 INFO - 'download_symbols': 'ondemand', 20:09:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:42 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:42 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:42 INFO - 'installer_path': 'installer.exe', 20:09:42 INFO - 'log_level': 'info', 20:09:42 INFO - 'log_name': 'talos', 20:09:42 INFO - 'log_to_console': True, 20:09:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:42 INFO - 'opt_config_files': (), 20:09:42 INFO - 'pip_index': False, 20:09:42 INFO - 'sps_profile': False, 20:09:42 INFO - 'sps_profile_interval': 0, 20:09:42 INFO - 'suite': 'dromaeojs', 20:09:42 INFO - 'system_bits': '32', 20:09:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:42 INFO - 'title': 'talos-linux64-ix-048', 20:09:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:42 INFO - 'use_talos_json': True, 20:09:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:09:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:42 INFO - 'work_dir': 'build'} 20:09:42 INFO - ##### 20:09:42 INFO - ##### Running clobber step. 20:09:42 INFO - ##### 20:09:42 INFO - Running pre-action listener: _resource_record_pre_action 20:09:42 INFO - Running main action method: clobber 20:09:42 INFO - rmtree: /builds/slave/test-pgo/build 20:09:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:09:43 INFO - Running post-action listener: _resource_record_post_action 20:09:43 INFO - ##### 20:09:43 INFO - ##### Running read-buildbot-config step. 20:09:43 INFO - ##### 20:09:43 INFO - Running pre-action listener: _resource_record_pre_action 20:09:43 INFO - Running main action method: read_buildbot_config 20:09:43 INFO - Using buildbot properties: 20:09:43 INFO - { 20:09:43 INFO - "project": "", 20:09:43 INFO - "product": "firefox", 20:09:43 INFO - "script_repo_revision": "production", 20:09:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:09:43 INFO - "repository": "", 20:09:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:09:43 INFO - "buildid": "20160323173027", 20:09:43 INFO - "pgo_build": "True", 20:09:43 INFO - "basedir": "/builds/slave/test-pgo", 20:09:43 INFO - "buildnumber": 1027, 20:09:43 INFO - "slavename": "talos-linux64-ix-048", 20:09:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:09:43 INFO - "platform": "ubuntu64_hw", 20:09:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:43 INFO - "branch": "fx-team", 20:09:43 INFO - "repo_path": "integration/fx-team", 20:09:43 INFO - "revision": "b999fac0569d760e971b6579c420eb887d645433", 20:09:43 INFO - "stage_platform": "linux64-pgo", 20:09:43 INFO - "builduid": "960c1cb2ea02476696a7b04e6e357fe3", 20:09:43 INFO - "slavebuilddir": "test" 20:09:43 INFO - } 20:09:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:09:43 INFO - Running post-action listener: _resource_record_post_action 20:09:43 INFO - ##### 20:09:43 INFO - ##### Running download-and-extract step. 20:09:43 INFO - ##### 20:09:43 INFO - Running pre-action listener: _resource_record_pre_action 20:09:43 INFO - Running main action method: download_and_extract 20:09:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:09: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')]} 20:09:43 INFO - https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:09:47 INFO - Downloaded 1361 bytes. 20:09:47 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:47 INFO - Using the following test package requirements: 20:09:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'jsshell-linux-x86_64.zip'], 20:09:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:47 INFO - https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:49 INFO - Downloaded 23633906 bytes. 20:09:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:09:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:09:50 INFO - Return code: 0 20:09:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:50 INFO - https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:58 INFO - Downloaded 23633906 bytes. 20:09:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:09:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:09:59 INFO - Return code: 0 20:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:59 INFO - https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:10:01 INFO - Downloaded 10847187 bytes. 20:10:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:10:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:10:01 INFO - Return code: 0 20:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:01 INFO - https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:10:03 INFO - Downloaded 57708399 bytes. 20:10:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:10:03 INFO - mkdir: /builds/slave/test-pgo/properties 20:10:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:10:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:10:03 INFO - Contents: 20:10:03 INFO - build_url:https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:10:04 INFO - Running post-action listener: _resource_record_post_action 20:10:04 INFO - Running post-action listener: set_extra_try_arguments 20:10:04 INFO - ##### 20:10:04 INFO - ##### Running populate-webroot step. 20:10:04 INFO - ##### 20:10:04 INFO - Running pre-action listener: _resource_record_pre_action 20:10:04 INFO - Running main action method: populate_webroot 20:10:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:10:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:10:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:10:04 INFO - '--tppagecycles', 20:10:04 INFO - '7'], 20:10:04 INFO - 'tests': ['tsvgm']}}, 20:10:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:10:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:10:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:10:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:10:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'tests': ['damp', 'tps']}, 20:10:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['damp', 'tps']}, 20:10:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:10:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:10:04 INFO - 'other': {'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'other_l64': {'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'other_nol64': {'tests': ['a11yr', 20:10:04 INFO - 'ts_paint', 20:10:04 INFO - 'tpaint', 20:10:04 INFO - 'sessionrestore', 20:10:04 INFO - 'sessionrestore_no_auto_restore', 20:10:04 INFO - 'tabpaint']}, 20:10:04 INFO - 'svgr': {'tests': ['tsvgx', 20:10:04 INFO - 'tsvgr_opacity', 20:10:04 INFO - 'tart', 20:10:04 INFO - 'tscrollx', 20:10:04 INFO - 'cart']}, 20:10:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['tsvgx', 20:10:04 INFO - 'tsvgr_opacity', 20:10:04 INFO - 'tart', 20:10:04 INFO - 'tscrollx', 20:10:04 INFO - 'cart']}, 20:10:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'tests': ['tp5o']}, 20:10:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'talos_options': ['--e10s'], 20:10:04 INFO - 'tests': ['tp5o']}, 20:10:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'talos_options': ['--xperf_path', 20:10:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:04 INFO - 'tests': ['tp5n']}, 20:10:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:04 INFO - 'talos_options': ['--e10s', 20:10:04 INFO - '--xperf_path', 20:10:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:04 INFO - 'tests': ['tp5n']}}, 20:10:04 INFO - 'talos.zip': {'path': '', 20:10:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:10:04 INFO - Running post-action listener: _resource_record_post_action 20:10:04 INFO - ##### 20:10:04 INFO - ##### Running create-virtualenv step. 20:10:04 INFO - ##### 20:10:04 INFO - Running pre-action listener: _resource_record_pre_action 20:10:04 INFO - Running main action method: create_virtualenv 20:10:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:10:04 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 20:10:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:10:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:10:04 INFO - Using real prefix '/usr' 20:10:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:10:05 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:07 INFO - Installing pip.................done. 20:10:07 INFO - Return code: 0 20:10:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:07 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:07 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 20:10:07 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 20:10:07 INFO - Using env: {'DISPLAY': ':0', 20:10:07 INFO - 'HOME': '/home/cltbld', 20:10:07 INFO - 'LANG': 'en_US.UTF-8', 20:10:07 INFO - 'LANGUAGE': 'en_US:en', 20:10:07 INFO - 'LOGNAME': 'cltbld', 20:10:07 INFO - 'MAIL': '/var/mail/cltbld', 20:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:07 INFO - 'MOZ_NO_REMOTE': '1', 20:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:07 INFO - 'NO_EM_RESTART': '1', 20:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:07 INFO - 'SHELL': '/bin/bash', 20:10:07 INFO - 'SHLVL': '1', 20:10:07 INFO - 'TERM': 'linux', 20:10:07 INFO - 'TMOUT': '86400', 20:10:07 INFO - 'USER': 'cltbld', 20:10:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:07 INFO - '_': '/tools/buildbot/bin/python'} 20:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:07 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 20:10:07 INFO - Cleaning up... 20:10:07 INFO - Return code: 0 20:10:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:07 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:07 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 20:10:07 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 20:10:07 INFO - Using env: {'DISPLAY': ':0', 20:10:07 INFO - 'HOME': '/home/cltbld', 20:10:07 INFO - 'LANG': 'en_US.UTF-8', 20:10:07 INFO - 'LANGUAGE': 'en_US:en', 20:10:07 INFO - 'LOGNAME': 'cltbld', 20:10:07 INFO - 'MAIL': '/var/mail/cltbld', 20:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:07 INFO - 'MOZ_NO_REMOTE': '1', 20:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:07 INFO - 'NO_EM_RESTART': '1', 20:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:07 INFO - 'SHELL': '/bin/bash', 20:10:07 INFO - 'SHLVL': '1', 20:10:07 INFO - 'TERM': 'linux', 20:10:07 INFO - 'TMOUT': '86400', 20:10:07 INFO - 'USER': 'cltbld', 20:10:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:07 INFO - '_': '/tools/buildbot/bin/python'} 20:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:07 INFO - Downloading/unpacking psutil>=0.7.1 20:10:07 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 20:10:07 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 20:10:07 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 20:10:07 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 20:10:07 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 20:10:07 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 20:10:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:09 INFO - Installing collected packages: psutil 20:10:09 INFO - Running setup.py install for psutil 20:10:09 INFO - building 'psutil._psutil_linux' extension 20:10:09 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 20:10:09 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 20:10:09 INFO - building 'psutil._psutil_posix' extension 20:10:09 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 20:10:09 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 20:10:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:10 INFO - Successfully installed psutil 20:10:10 INFO - Cleaning up... 20:10:10 INFO - Return code: 0 20:10:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:10 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:10 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 20:10:10 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 20:10:10 INFO - Using env: {'DISPLAY': ':0', 20:10:10 INFO - 'HOME': '/home/cltbld', 20:10:10 INFO - 'LANG': 'en_US.UTF-8', 20:10:10 INFO - 'LANGUAGE': 'en_US:en', 20:10:10 INFO - 'LOGNAME': 'cltbld', 20:10:10 INFO - 'MAIL': '/var/mail/cltbld', 20:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:10 INFO - 'MOZ_NO_REMOTE': '1', 20:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:10 INFO - 'NO_EM_RESTART': '1', 20:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:10 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:10 INFO - 'SHELL': '/bin/bash', 20:10:10 INFO - 'SHLVL': '1', 20:10:10 INFO - 'TERM': 'linux', 20:10:10 INFO - 'TMOUT': '86400', 20:10:10 INFO - 'USER': 'cltbld', 20:10:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:10 INFO - '_': '/tools/buildbot/bin/python'} 20:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:10:10 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 20:10:10 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 20:10:10 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 20:10:10 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 20:10:10 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 20:10:10 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 20:10:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:10:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:10:12 INFO - Installing collected packages: mozsystemmonitor 20:10:12 INFO - Running setup.py install for mozsystemmonitor 20:10:12 INFO - Successfully installed mozsystemmonitor 20:10:12 INFO - Cleaning up... 20:10:12 INFO - Return code: 0 20:10:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:10:12 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')]} 20:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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')]} 20:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:12 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 20:10:12 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 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:12 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 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 20:10:14 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:14 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 20:10:14 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 20:10:14 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 20:10:14 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 20:10:14 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 20:10:14 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 20:10:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:10:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:15 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 20:10:15 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 20:10:15 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 20:10:15 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 20:10:15 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 20:10:15 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 20:10:15 INFO - Downloading docopt-0.6.1.tar.gz 20:10:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:15 INFO - Running setup.py install for blobuploader 20:10:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:10:15 INFO - Running setup.py install for requests 20:10:15 INFO - Running setup.py install for docopt 20:10:15 INFO - Successfully installed blobuploader requests docopt 20:10:15 INFO - Cleaning up... 20:10:15 INFO - Return code: 0 20:10:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:15 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:15 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 20:10:15 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 20:10:15 INFO - Using env: {'DISPLAY': ':0', 20:10:15 INFO - 'HOME': '/home/cltbld', 20:10:15 INFO - 'LANG': 'en_US.UTF-8', 20:10:15 INFO - 'LANGUAGE': 'en_US:en', 20:10:15 INFO - 'LOGNAME': 'cltbld', 20:10:15 INFO - 'MAIL': '/var/mail/cltbld', 20:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:15 INFO - 'MOZ_NO_REMOTE': '1', 20:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:15 INFO - 'NO_EM_RESTART': '1', 20:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:15 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:15 INFO - 'SHELL': '/bin/bash', 20:10:15 INFO - 'SHLVL': '1', 20:10:15 INFO - 'TERM': 'linux', 20:10:15 INFO - 'TMOUT': '86400', 20:10:15 INFO - 'USER': 'cltbld', 20:10:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:15 INFO - '_': '/tools/buildbot/bin/python'} 20:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:10:16 INFO - Running setup.py (path:/tmp/pip-2WxhjI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:10:16 INFO - Running setup.py (path:/tmp/pip-roitoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:10:16 INFO - Running setup.py (path:/tmp/pip-GcmKSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:10:16 INFO - Running setup.py (path:/tmp/pip-lmHUzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:10:16 INFO - Running setup.py (path:/tmp/pip-1xmKus-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:10:16 INFO - Running setup.py (path:/tmp/pip-Py82UK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:10:16 INFO - Running setup.py (path:/tmp/pip-gYi3hI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:10:16 INFO - Running setup.py (path:/tmp/pip-Hrv8sP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:10:16 INFO - Running setup.py (path:/tmp/pip-BlwngR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:10:16 INFO - Running setup.py (path:/tmp/pip-btcT7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:10:16 INFO - Running setup.py (path:/tmp/pip-32sE7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:10:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:10:16 INFO - Running setup.py (path:/tmp/pip-MJheMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:10:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:10:17 INFO - Running setup.py (path:/tmp/pip-TUVOTB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:10:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:10:17 INFO - Running setup.py (path:/tmp/pip-Mu5MoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:10:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:10:17 INFO - Running setup.py (path:/tmp/pip-v66Xq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:10:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:10:17 INFO - Running setup.py (path:/tmp/pip-VSHIVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:10:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:10:17 INFO - Running setup.py (path:/tmp/pip-5eLcpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:10:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:17 INFO - Running setup.py install for manifestparser 20:10:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:10:17 INFO - Running setup.py install for mozcrash 20:10:17 INFO - Running setup.py install for mozdebug 20:10:17 INFO - Running setup.py install for mozdevice 20:10:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:10:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:10:17 INFO - Running setup.py install for mozfile 20:10:17 INFO - Running setup.py install for mozhttpd 20:10:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozinfo 20:10:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozInstall 20:10:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozleak 20:10:18 INFO - Running setup.py install for mozlog 20:10:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for moznetwork 20:10:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozprocess 20:10:18 INFO - Running setup.py install for mozprofile 20:10:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozrunner 20:10:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:10:18 INFO - Running setup.py install for mozscreenshot 20:10:18 INFO - Running setup.py install for moztest 20:10:19 INFO - Running setup.py install for mozversion 20:10:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:10:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:19 INFO - Cleaning up... 20:10:19 INFO - Return code: 0 20:10:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:10: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')]} 20:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:19 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:19 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 20:10:19 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 20:10:19 INFO - Using env: {'DISPLAY': ':0', 20:10:19 INFO - 'HOME': '/home/cltbld', 20:10:19 INFO - 'LANG': 'en_US.UTF-8', 20:10:19 INFO - 'LANGUAGE': 'en_US:en', 20:10:19 INFO - 'LOGNAME': 'cltbld', 20:10:19 INFO - 'MAIL': '/var/mail/cltbld', 20:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:19 INFO - 'MOZ_NO_REMOTE': '1', 20:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:19 INFO - 'NO_EM_RESTART': '1', 20:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:19 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:19 INFO - 'SHELL': '/bin/bash', 20:10:19 INFO - 'SHLVL': '1', 20:10:19 INFO - 'TERM': 'linux', 20:10:19 INFO - 'TMOUT': '86400', 20:10:19 INFO - 'USER': 'cltbld', 20:10:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:19 INFO - '_': '/tools/buildbot/bin/python'} 20:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:10:19 INFO - Running setup.py (path:/tmp/pip-wcGUAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:10:19 INFO - Running setup.py (path:/tmp/pip-8_1Vwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:10:19 INFO - Running setup.py (path:/tmp/pip-sgJqSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:10:19 INFO - Running setup.py (path:/tmp/pip-_fGvVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:10:19 INFO - Running setup.py (path:/tmp/pip-J1liFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:10:19 INFO - Running setup.py (path:/tmp/pip-mK1399-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:10:19 INFO - Running setup.py (path:/tmp/pip-N4Ados-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:10:19 INFO - Running setup.py (path:/tmp/pip-IOiJ_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:10:19 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)) 20:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:10:19 INFO - Running setup.py (path:/tmp/pip-RjCoEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:10:20 INFO - Running setup.py (path:/tmp/pip-WTbQH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:10:20 INFO - Running setup.py (path:/tmp/pip-wSDGWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:10:20 INFO - Running setup.py (path:/tmp/pip-bAtcRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:10:20 INFO - Running setup.py (path:/tmp/pip-rNBTBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:10:20 INFO - Running setup.py (path:/tmp/pip-pHVaxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:10:20 INFO - Running setup.py (path:/tmp/pip-xSH_Sv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:10:20 INFO - Running setup.py (path:/tmp/pip-dJtW9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:10:20 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)) 20:10:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:10:20 INFO - Running setup.py (path:/tmp/pip-9eg29S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:10:20 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)) 20:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:10:20 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)) 20:10:20 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)) 20:10:20 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)) 20:10:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:22 INFO - Downloading blessings-1.6.tar.gz 20:10:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:22 INFO - Installing collected packages: blessings 20:10:22 INFO - Running setup.py install for blessings 20:10:22 INFO - Successfully installed blessings 20:10:22 INFO - Cleaning up... 20:10:22 INFO - Return code: 0 20:10:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:10:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:10:22 INFO - Reading from file tmpfile_stdout 20:10:22 INFO - Current package versions: 20:10:22 INFO - argparse == 1.2.1 20:10:22 INFO - blessings == 1.6 20:10:22 INFO - blobuploader == 1.2.4 20:10:22 INFO - docopt == 0.6.1 20:10:22 INFO - manifestparser == 1.1 20:10:22 INFO - mozInstall == 1.12 20:10:22 INFO - mozcrash == 0.17 20:10:22 INFO - mozdebug == 0.1 20:10:22 INFO - mozdevice == 0.48 20:10:22 INFO - mozfile == 1.2 20:10:22 INFO - mozhttpd == 0.7 20:10:22 INFO - mozinfo == 0.9 20:10:22 INFO - mozleak == 0.1 20:10:22 INFO - mozlog == 3.1 20:10:22 INFO - moznetwork == 0.27 20:10:22 INFO - mozprocess == 0.22 20:10:22 INFO - mozprofile == 0.28 20:10:22 INFO - mozrunner == 6.11 20:10:22 INFO - mozscreenshot == 0.1 20:10:22 INFO - mozsystemmonitor == 0.0 20:10:22 INFO - moztest == 0.7 20:10:22 INFO - mozversion == 1.4 20:10:22 INFO - psutil == 3.1.1 20:10:22 INFO - requests == 1.2.3 20:10:22 INFO - wsgiref == 0.1.2 20:10:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:22 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:22 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 20:10:22 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 20:10:22 INFO - Using env: {'DISPLAY': ':0', 20:10:22 INFO - 'HOME': '/home/cltbld', 20:10:22 INFO - 'LANG': 'en_US.UTF-8', 20:10:22 INFO - 'LANGUAGE': 'en_US:en', 20:10:22 INFO - 'LOGNAME': 'cltbld', 20:10:22 INFO - 'MAIL': '/var/mail/cltbld', 20:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:22 INFO - 'MOZ_NO_REMOTE': '1', 20:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:22 INFO - 'NO_EM_RESTART': '1', 20:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:22 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:22 INFO - 'SHELL': '/bin/bash', 20:10:22 INFO - 'SHLVL': '1', 20:10:22 INFO - 'TERM': 'linux', 20:10:22 INFO - 'TMOUT': '86400', 20:10:22 INFO - 'USER': 'cltbld', 20:10:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:22 INFO - '_': '/tools/buildbot/bin/python'} 20:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 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)) 20:10:23 INFO - Cleaning up... 20:10:23 INFO - Return code: 0 20:10:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:10:23 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')]} 20:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 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')]} 20:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:23 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 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10:23 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 20:10:23 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 20:10:23 INFO - Using env: {'DISPLAY': ':0', 20:10:23 INFO - 'HOME': '/home/cltbld', 20:10:23 INFO - 'LANG': 'en_US.UTF-8', 20:10:23 INFO - 'LANGUAGE': 'en_US:en', 20:10:23 INFO - 'LOGNAME': 'cltbld', 20:10:23 INFO - 'MAIL': '/var/mail/cltbld', 20:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:23 INFO - 'MOZ_NO_REMOTE': '1', 20:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:23 INFO - 'NO_EM_RESTART': '1', 20:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:23 INFO - 'SHELL': '/bin/bash', 20:10:23 INFO - 'SHLVL': '1', 20:10:23 INFO - 'TERM': 'linux', 20:10:23 INFO - 'TMOUT': '86400', 20:10:23 INFO - 'USER': 'cltbld', 20:10:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:23 INFO - '_': '/tools/buildbot/bin/python'} 20:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:23 INFO - Downloading/unpacking jsonschema 20:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:25 INFO - Downloading/unpacking functools32 (from jsonschema) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:25 INFO - warning: no files found matching '*.txt' 20:10:25 INFO - no previously-included directories found matching 'build' 20:10:25 INFO - no previously-included directories found matching 'dist' 20:10:25 INFO - no previously-included directories found matching '.git*' 20:10:25 INFO - Installing collected packages: jsonschema, functools32 20:10:25 INFO - Running setup.py install for functools32 20:10:25 INFO - warning: no files found matching '*.txt' 20:10:25 INFO - no previously-included directories found matching 'build' 20:10:25 INFO - no previously-included directories found matching 'dist' 20:10:25 INFO - no previously-included directories found matching '.git*' 20:10:25 INFO - Successfully installed jsonschema functools32 20:10:25 INFO - Cleaning up... 20:10:25 INFO - Return code: 0 20:10:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:10: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')]} 20:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7afc103f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe936b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, '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': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', '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 20:10: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', 'flake8'] in /builds/slave/test-pgo/build 20:10: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 flake8 20:10:25 INFO - Using env: {'DISPLAY': ':0', 20:10:25 INFO - 'HOME': '/home/cltbld', 20:10:25 INFO - 'LANG': 'en_US.UTF-8', 20:10:25 INFO - 'LANGUAGE': 'en_US:en', 20:10:25 INFO - 'LOGNAME': 'cltbld', 20:10:25 INFO - 'MAIL': '/var/mail/cltbld', 20:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:25 INFO - 'MOZ_NO_REMOTE': '1', 20:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:25 INFO - 'NO_EM_RESTART': '1', 20:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:25 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:25 INFO - 'SHELL': '/bin/bash', 20:10:25 INFO - 'SHLVL': '1', 20:10:25 INFO - 'TERM': 'linux', 20:10:25 INFO - 'TMOUT': '86400', 20:10:25 INFO - 'USER': 'cltbld', 20:10:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:25 INFO - '_': '/tools/buildbot/bin/python'} 20:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:26 INFO - Downloading/unpacking flake8 20:10:26 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 20:10:26 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 20:10:26 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 20:10:26 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 20:10:26 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 20:10:26 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 20:10:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:10:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:10:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:28 INFO - no previously-included directories found matching 'docs/_build' 20:10:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:10:28 INFO - Running setup.py install for pep8 20:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:28 INFO - no previously-included directories found matching 'docs/_build' 20:10:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:10:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:10:28 INFO - Cleaning up... 20:10:28 INFO - Return code: 0 20:10:28 INFO - Running post-action listener: _resource_record_post_action 20:10:28 INFO - Running post-action listener: _start_resource_monitoring 20:10:28 INFO - Starting resource monitoring. 20:10:28 INFO - ##### 20:10:28 INFO - ##### Running install step. 20:10:28 INFO - ##### 20:10:28 INFO - Running pre-action listener: _resource_record_pre_action 20:10:28 INFO - Running main action method: install 20:10:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:10:29 INFO - Reading from file tmpfile_stdout 20:10:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:10:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:10:29 INFO - Reading from file tmpfile_stdout 20:10:29 INFO - Output received: 20:10:29 INFO - Usage: mozinstall [options] installer 20:10:29 INFO - Options: 20:10:29 INFO - -h, --help show this help message and exit 20:10:29 INFO - -d DEST, --destination=DEST 20:10:29 INFO - Directory to install application into. [default: 20:10:29 INFO - "/builds/slave/test-pgo"] 20:10:29 INFO - --app=APP Application being installed. [default: firefox] 20:10:29 INFO - mkdir: /builds/slave/test-pgo/build/application 20:10:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:10:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:10:45 INFO - Reading from file tmpfile_stdout 20:10:45 INFO - Output received: 20:10:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:10:45 INFO - Running post-action listener: _resource_record_post_action 20:10:45 INFO - ##### 20:10:45 INFO - ##### Running run-tests step. 20:10:45 INFO - ##### 20:10:45 INFO - Running pre-action listener: _resource_record_pre_action 20:10:45 INFO - Running main action method: run_tests 20:10:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:10:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:10:45 INFO - Python 2.7.3 20:10:45 INFO - Return code: 0 20:10:45 INFO - grabbing minidump binary from tooltool 20:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:45 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 0xe8e1d0>, '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 0xe91750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:10:45 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 20:10:45 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 20:10:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:45 INFO - Return code: 0 20:10:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:10:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:10:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:10:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:10:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:10:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:10:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:10:46 INFO - Return code: 0 20:10:46 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/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:10:46 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/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 20:10:46 INFO - Using env: {'DISPLAY': ':0', 20:10:46 INFO - 'HOME': '/home/cltbld', 20:10:46 INFO - 'LANG': 'en_US.UTF-8', 20:10:46 INFO - 'LANGUAGE': 'en_US:en', 20:10:46 INFO - 'LOGNAME': 'cltbld', 20:10:46 INFO - 'MAIL': '/var/mail/cltbld', 20:10:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:10:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:46 INFO - 'MOZ_NO_REMOTE': '1', 20:10:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:46 INFO - 'NO_EM_RESTART': '1', 20:10:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:10:46 INFO - 'SHELL': '/bin/bash', 20:10:46 INFO - 'SHLVL': '1', 20:10:46 INFO - 'TERM': 'linux', 20:10:46 INFO - 'TMOUT': '86400', 20:10:46 INFO - 'USER': 'cltbld', 20:10:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680', 20:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:46 INFO - '_': '/tools/buildbot/bin/python'} 20:10:46 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/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:10:46 INFO - mozversion application_buildid: 20160323173027 20:10:46 INFO - mozversion application_changeset: b999fac0569d760e971b6579c420eb887d645433 20:10:46 INFO - mozversion application_display_name: Nightly 20:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:46 INFO - mozversion application_name: Firefox 20:10:46 INFO - mozversion application_remotingname: firefox 20:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:46 INFO - mozversion application_vendor: Mozilla 20:10:46 INFO - mozversion application_version: 48.0a1 20:10:46 INFO - mozversion platform_buildid: 20160323173027 20:10:46 INFO - mozversion platform_changeset: b999fac0569d760e971b6579c420eb887d645433 20:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:46 INFO - mozversion platform_version: 48.0a1 20:10:46 INFO - using testdate: 1458789046 20:10:46 INFO - actual date: 1458789046 20:10:46 INFO - starting webserver on 'localhost:44040' 20:10:46 INFO - SUITE-START | Running 2 tests 20:10:46 INFO - TEST-START | dromaeo_css 20:10:46 INFO - operating with platform_type : linux_ 20:10:46 INFO - Initialising browser for dromaeo_css test... 20:10:46 INFO - TEST-INFO | started process 8037 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwV6Wd/profile http://localhost:44040/getInfo.html) 20:10:51 INFO - PROCESS | 8037 | __metrics Screen width/height:1600/1200 20:10:51 INFO - PROCESS | 8037 | colorDepth:24 20:10:51 INFO - PROCESS | 8037 | Browser inner width/height: 1024/697 20:10:51 INFO - PROCESS | 8037 | __metrics 20:10:52 ERROR - PROCESS | 8037 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:10:53 INFO - TEST-INFO | 8037: exit 0 20:10:53 INFO - Browser initialized. 20:10:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:53 INFO - TEST-INFO | started process 8134 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwV6Wd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:04 INFO - PROCESS | 8134 | RSS: Main: 156372992 20:11:04 INFO - PROCESS | 8134 | 20:11:56 INFO - PROCESS | 8134 | 1458789116487 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] 20:14:02 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44040/tests/dromaeo/cssquery-ext.html) 20:14:03 INFO - PROCESS | 8134 | RSS: Main: 263643136 20:14:03 INFO - PROCESS | 8134 | 20:17:06 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-ext.html (next: http://localhost:44040/tests/dromaeo/cssquery-jquery.html) 20:17:06 INFO - PROCESS | 8134 | RSS: Main: 232370176 20:17:06 INFO - PROCESS | 8134 | 20:20:08 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44040/tests/dromaeo/cssquery-mootools.html) 20:20:09 INFO - PROCESS | 8134 | RSS: Main: 225980416 20:20:09 INFO - PROCESS | 8134 | 20:23:10 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44040/tests/dromaeo/cssquery-prototype.html) 20:23:11 INFO - PROCESS | 8134 | RSS: Main: 222982144 20:23:11 INFO - PROCESS | 8134 | 20:26:14 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44040/tests/dromaeo/cssquery-yui.html) 20:26:14 INFO - PROCESS | 8134 | RSS: Main: 220684288 20:26:14 INFO - PROCESS | 8134 | 20:29:16 INFO - PROCESS | 8134 | Cycle 1(1): loaded http://localhost:44040/tests/dromaeo/cssquery-yui.html (next: http://localhost:44040/tests/dromaeo/cssquery-dojo.html) 20:29:17 INFO - PROCESS | 8134 | RSS: Main: 263278592 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | __start_tp_report 20:29:17 INFO - PROCESS | 8134 | _x_x_mozilla_page_load 20:29:17 INFO - PROCESS | 8134 | _x_x_mozilla_page_load_details 20:29:17 INFO - PROCESS | 8134 | |i|pagename|runs| 20:29:17 INFO - PROCESS | 8134 | |0;dojo.html;2952.2766922104083;3035.635723713152;3058.525928481085;3086.2747254395213;3118.0645806258117;5095.490450954902;5162.38051433828;5209.86975325617;5223.5037671421205;5253.658512196705;5168.689878607277;5183.663061900983;5184.092783762836;5191.5846732261425;5194.506521880416;4647.651426143036;4674.813007479696;4791.736454495001;4799.928001079987;4826.444958829727;4608.838690645828;4752.9762351188365;4778.928316075262;4796.25658023007;4805.231163013918;4683.063387322549;4710.010897711485;4713.198756211452;4733.124371991158;4750.548697873696;4657.4876763555985;4667;4676.064787042571;4689.085628302482;4701.247800351927;4540.818367265306;4643.8142474300985;4657.487676355632;4664.790084446208;4714.033623107289;5105;5114.565261952738;5120.539151476348;5124.615653825941;5132.589392848563;5524.944750552523;5541.861453463655;5548.029094908375;5599.132134519156;5599.272094627713;5434.538064264542;5485.396606373296;5546.861328466821;5549.77800887964;5555.2778138842095;5223.3209682741;5262.473752624707;5266.631335806495;5268.894622107537;5271.499207575274;5733.226014488074;5734.77060917567;5757.280339957505;5757.8560535986935;5761.567882408836;5375.6774593524515;5479.315085614298;5496.367917689517;5501.9174712379345;5539.695316757537;5559.33288005442;5565.777368905279;5573.888522229533;5573.916391254134;5585.357683866326;5374.677519348852;5555.583331250092;5556;5560.527355174774;5613.382527921925;5446.2375267462585;5474.753636086386;5475.589330800206;5491.780328786884;5517.724113794295;4245.8513952011535;4255.021345090647;4263.637590804817;4268.87193384199;4299.570042995675;3763.360228761117;3794.392897136445;3818.0836599216545;3839.6352346527037;3858.3247931611854;5117.41149767774;5138.768755406016;5143.974280128576;5181.274621552986;5191.377034755854;5462.863428414242;5502.339719233718;5504.174373843955;5515.669059856422;5548.389677135512;5079.847604571869;5142.51146141116;5153.123968925292;5207.921881171786;5308.814191503279;4788.7366194859615;4805.447373552016;4807.711537307773;4815.470298267188;4855.757212139379;5777.537796976232;5786.652800831964;5793.623414478046;5799.768009279666;5800.187973683687;5427.6200665953;5521.1442226454965;5572.972135139217;5682.886342273048;5690.317161940594;5734.59857809966;5770.451807078321;5770.740316685676;5772.711364431846;5782.306123265235;5477.75350109254;5489.204065410573;5491.2312276282155;5494.890102197854;5495.258140151029;5461.5357694596405;5483.479069488392;5516;5548.195511650869;5565.165225216088;5330.466953304638;5354.705491198021;5355.2234925934745;5363.115086010921;5369.946300537101;5309;5312.203169524448;5341.065313570188;5341.893162136813;5383.16560933056;5216.634835561475;5227.503387178212;5243.134882744457;5243.475652434726;5283.996040752245;5426.860359324586;5443.455654434525;5456.263404440349;5460.290162278879;5471.8084867029465;5214;5293.602979776455;5364.302640656846;5407.297051383295;5417.214503896992 20:29:17 INFO - PROCESS | 8134 | |1;ext.html;510.39773067780004;554.8973439913614;560.218495199197;583.9357670656228;595.6009473652655;30277.394452110973;38684.22631547367;39029.609703902956;39062.60937390625;39063.41404878926;41809.79095104528;42003.789981050126;42267.577324226746;42316.788416057876;42381.78809105958;7746.264104910025;8581.098984606604;8778.780530486756;8786.956065219665;10125.797484050314;10176.08415242628;10304.639337623184;10309.226807989393;10318.58725650973;10334.276600637959;10172.338797978146;10327.58689652413;10328.431936243504;10329.741756456073;10333.586656533767;7988.920110798905;10200.387976721384;10365.585376584928;10639.893601063968;10648.840267395995;10057.647982320585;10088.848667269996;10188.541515631814;10192.133668638175;10200.591976320939;42264.78867605642;42531.57468425307;42586;42776.3583546247;42833.57166428327;3315.353506066318;3388.3562123196516;3398.201422665696;3557.324108419418;3817.5800661927165;33061;33370;33418;33982.32035359279;34110.48834267488;4334.783260836945;4353.891152721176;4386.144701783153;4414.845480408202;4452.109578084363;338914;341204.29397853103;341348;342429;343310;63193.36806631875;63495.7776477821;63577.50323732146;63684.36315636784;63718.36281637124;66535;66698.66650666813;66747.66626166838;66755.33244667492;66766.33233667698;16347.836521634868;16810.57973550671;16927.915360423118;16956.660866782597;16994.32022719102;13317.800232996513;13522.459101636021;13555.52555660567;13557.322133893265;13557.728845423233;19949.60100798005;20627.278045268344;21004.684929726067;21062.473438163863;21068.367948961557;6381.968090159519;7577.507462014952;7739.264769846855;7778.299953004257;7858.528488290721;987.0425687083517;1029.7951396865685;1066.461436974323;1100.339796122336;1212.8241404996402;28040;28382;28536.85731571329;28643;28664.426711466072;1167.8948894599357;1171.0982543441503;1203.9337836418906;1207.1368971185645;1260.1368062876775;14793.556193314218;14851.331690073972;15116.09303441797;15322.23388830554;15397.23013849303;373582;380066;380390;380991;431146;50524;50815.23777143346;51048.234276485884;51071.23393149106;51114;1392.352556061416;1402.922839243831;1407.176801571072;1431.6492459347526;1438.9424423022963;27755;30201.697983019887;31776.682233177373;31802.36395272128;31943.680563195;42923.78538107414;42981;42988.570114298454;42994;43054.569454305056;316270;325681;326001;327295;327328;30612;34949.65050349566;35484.46773298351;35656.64343356533;36114.63885361218;41607.58392416037;41795.37306940459;42104.57895421007;42249.78875105605;42536.78731606322;35356;35738.64261357353;35777.64222357743;36154.4576831353;37051.81474092612;35810.28379432449;38078.428823568225;38101.237975240896;38103;38335.42496862494;38458.80770596129;40806.79596601998;41227;41550.37674434826;41690.79154604329;32419.513707293936;34903.650963491054;35146.121346965505;35599.82200088983;35752.64247357493;27095.59356609692;27422;27446.725532744418;27463.17610471689;27840.303992400353 20:29:17 INFO - PROCESS | 8134 | |2;jquery.html;365.2166103707547;369.6950016236604;369.73009702916886;372.3614001986592;378.7065024605932;17674.11629418529;18001;18030.27878884843;18385.724214136797;18416.723749143774;17144.82855171448;17836.197371118298;18429.907850460728;18492.537686557844;18588.07059647019;5473.534749546293;5601.327840659126;5632.408597097307;5635.971820140893;5642.943570564283;4098.4671992640915;5498.422665620113;5823.3012038555435;6176.691165441733;6197.938020619804;6141;6155.26136863577;6166.321704612489;6179.7837075702355;6182.752689892422;5928.288605367362;6235.127082208472;6235.345288744707;6241.438270555626;6241.594296370744;3711.8329675164414;5263.105272103713;5471.288732464794;5485.890282194374;5491.643043202219;22887.54224915509;23148.53702925949;23274.883625581933;23854.88072559626;23887;2236.2396785092983;2366.3137690069857;2443.9389015274583;2612.9216123516326;2790.8696977724053;13685;13794.65513362164;13808.723825523533;13984.163635823088;14240.643983900485;1864.4499872537633;1917.4631103291101;1968.9507762305914;1979.0995097230868;1993.880367177974;72030.63984680043;73865.99999999946;74690.62654686747;74857.6257118711;75970;10468.633597824191;10565.200221941192;10953.616623418142;10974.945125274322;11161.609343672932;14366.281685915872;14390.136591804525;14395.78406323906;14436.639084022774;14449.34977925996;8275.213854683796;8607.139286071342;8608.268297194683;8748.562571871382;8750.168733970262;8683.108468975737;8712.041675415827;8735.650573977096;8740.562971851383;8804.823903521894;6673.666316684146;6681.930891057407;6710.630915299607;6750.594964302158;6758.797236082925;1745.2844333823073;1771.6988112020988;1789.9642007159784;1805.3590975203876;1818.1818181818078;967.7000129959595;1004.8643433136433;1010.0707349238718;1041.8072656558409;1049.7375656085978;19278.807211927702;19285.228590856488;19821.20715171377;19965.20139194416;20195;1053.3153450257394;1059.279689810936;1089.8310761831929;1126.920547617613;1143.279733767721;10826.188035897181;11285.322880627024;11308;11337.43312834355;11357.716057098638;435048;445154;497046;521064;524324;79382.20617793864;79588;80610.59694701488;84190.57904710437;84670.22284261453;1063.5958335832333;1066.9253152279266;1096.0245381610532;1102.6361300770727;1104.690686607751;16032.679346412773;16055;16247.268872900984;16259.837401625833;16498;35475.82262088673;35531;35713.1071723209;36496.27007459889;36683.26633467369;45963;46242.53757462382;46507.767461162475;46624;46814.29778553393;7778.766637000899;7941.523508589503;7946.125926148004;7973.561454119847;8026.558539280396;11434.599789007345;12375.381230938598;12646.367681616066;12664.936675316932;13064.150830196008;11185.272957257752;11386;11494.885051149717;11610.535578576762;11940.104492163297;11413.372264525531;11413.714657133638;11510;11613.3612651305;11645.6506304811;11241.550337986717;11659.88340116588;11670.824937625772;11676.182667213554;11780.70548236301;7451.40388768908;7810.414218933716;7831.373490120891;7984.361251099782;8009.399295053011;11395.658130256106;11451.48468318911;11553.768924621629;11600.361980091177;11714.23857449263 20:29:17 INFO - PROCESS | 8134 | |3;mootools.html;1353.3165751295594;1475.9188244646543;1510.10148961368;1684.949451516455;1832.3586744639379;7845.09781375142;7960.7213747518845;7987;8030.397720170996;8037;7838.412119091063;7967.521948683083;7985.40109491789;7998.720044798433;8000.639971201295;1993.1628715939269;2237.2281562860785;2244.876531790751;2255.875926824024;2306.261996161229;2111.9049642766113;2145.0561752828708;2150.580636775829;2152.278986539511;2152.698622192894;2221.466847956487;2283.3264187064856;2284.817214622826;2285.5771682238756;2288.9198878039274;2245.7978781909624;2267.478479949604;2271.159670921753;2293.094227780026;2300.470891694911;2216.9778302216932;2223.433024578722;2244.3827947314458;2258.5482903419384;2259.548090381914;7961.323287520568;8030.036395632562;8032.1566235545015;8032.558209298486;8034.9598252008955;4935.481774413706;5044.899102017976;5046.495350464924;5054.115529782273;5060.063888180698;3269.53150371468;3272.689094536039;3315.8176300303476;3326.6839650233187;3357.143928298293;1039.0285083447002;2102.1591363454586;2193.5941850757663;2196.1983875885185;2198.428408613756;10904.07315378186;11071.280366776135;11092.778144437147;11094.1124710023;11098.944505277503;4257.446531950888;4407.338899165151;4414.668899832525;4442.267025940748;4445.444319460067;9583.712488625353;9609.663661771805;9625.181859541877;9638.180754635794;9641.758956026155;4551.8179272829375;5026.045051440215;5026.547610715053;5028.673136246132;5103.642745007888;4472.284434490531;4550.635949124062;4576.88557786058;4621.445426548836;4625.907481850344;3809.2000679857542;3890.5331360236387;3898.3762597984187;3916.7258291919293;3945.921081578352;1144.1876267849752;1187;1189.7679952409196;1198.484651599803;1207.6256360528089;1317.7496275707585;1335.7128217433103;1348.8246527951303;1385.6189547874415;1386.2583517817918;7543.811404714926;7591.4685971981435;7635.350995165473;7641.3886889048745;7643.121041080236;437.6236436664466;447.2642503082411;449.93925820014533;451.907358991406;453.2391658407112;5926.407359264039;5951.672658003765;5964;5983.551233657493;5991.730372133265;9498.95250523743;9960.950195248977;9971.351862128939;10094.747631309128;10108.24188185889;9963.850542241873;10023.548940297704;10023.749406264902;10048.246381521416;10065.245106617032;7463.589502577411;7765.650545725456;7787;7839.686412543434;7862.842743145219;7078.221395646372;7124;7140.393066589398;7147;7151.4278857690215;8500.659973600987;8918.777030574287;8997.820043599222;9110.590023449093;9114.544272786201;8737.038925718292;8762.780930476789;8948.105189481;8950.462972221687;8993.415427997159;6502.6748662567625;6670.166229221348;7002.124734408199;7211.098612673416;7321.341079302888;7745.148033716399;7751;7753.534787912743;7792.220777922389;7794.064712234568;6813.250542440229;7042.190148132825;7042.542234754725;7138.0363650906465;7142.607156606437;6896.310368963063;7000.334968178015;7031.40233080194;7032.156141263081;7105.431565474646;7090.822729431806;7091.716331346688;7245.021922040457;7395.519291246267;7403.481756277224;6555.2133743951035;6578.671066446755;6602.801915942529;6608.933910660832;6630.038644396439;6305.369463053658;6334.9366506334345;6345.0482427636225;6415.550911436155;6539.149910511603 20:29:17 INFO - PROCESS | 8134 | |4;prototype.html;307.33308720077434;313.1638525137882;318.64789407704484;320.9374172036454;325.04599001929324;5893;5918.881622367556;5919.940800591993;5930.229070220876;5934.643921364721;5804.448577385152;5829.446202610745;5913.881722365551;5920.75011495631;5932;4265.594768496995;4356.629686476654;4363.978180109111;4428.114377124572;4460.1525710114975;4422.402975598301;4460.531644177363;4464.531224221459;4464.955350446503;4471.642268618502;4404.053128577355;4410.80151393188;4413.117376524708;4415.602595766381;4420.9336859947125;4239.872803815875;4306.7631280279575;4398.252297109499;4409.867703968886;4412.558744125594;3829.0810205550747;3831.63599458051;3837.597052309495;3839.8464061437508;3844.442555829389;5683.175939488751;5689.345725241567;5692.345380281279;5697.259356283656;5699.458551437607;5159.406668233164;5169.198774190007;5176.016556854186;5176.50823171798;5185.585153187736;6194.4425001749605;6215.192025036717;6217.502599792006;6219.533534984895;6224;4065.8983525411804;4195.098053918392;4202.159568086395;4307.870763877088;4308.3537469379535;6510.18622672166;6544.476441884638;6546.869062618721;6573.474122070271;6577.6711164441585;4298.763568003727;4301.139772045541;4301.2257793597455;4302.247106756305;4307.375430562551;4364.803583838735;4368;4368.27923392643;4368.322909948963;4376.256036473807;5104.617153713486;5108.259302401131;5113.463086375951;5118.38579370478;5121.590272778169;6122.081687746873;6302.180716506825;6308.89594320992;6312.652804095819;6315.431611155018;1518.2105305241212;1528.3122594832148;1536.2011753887916;1537.9692406151814;1539.2996186735008;942.2697409507687;994.2692121290845;998.9100980911753;1002.9949850250702;1016.0499932563077;5881.941180588225;5899.321578018497;5940.257467816523;5949.167116603679;5949.762009519657;6403.807885763435;6434.935650643527;6438.195225596801;6438.517111216677;6448.1295025171;5912.940870591325;5926.259217597801;5928.140419639129;5937.376575459514;5943.613665111754;3450.1202193440513;3476.687098161178;3483.512308276843;3486.790792552455;3499.825008749552;6621.470282377399;6674.866502670016;6705.228898676617;6862.279460656659;6876.209235937831;6692.899606505906;6717.261101278856;6718.193816741925;6722.630255336004;6733.158355205599;6836.726530938707;6841.144856892888;6841.657917104224;6844.863102737917;6845.623490708059;6576.506761992774;6581.605103693793;6584.407403333723;6590.604563726191;6593.3736295051895;6284.968575157095;6434.806955791334;6486.967565162144;6515.804525864231;6517.4134327910715;6764.594124352555;6873.725050997904;6897.206821215424;6900.758473453405;6913.93086069153;4439.356293337512;4476.4180656514445;4477.776111194493;4480.551944805624;4483.125790470827;6517.674116294261;6517.902231466626;6524.869502610016;6533.771318003847;6534.901976470262;6353.555251132377;6354.4916406686425;6366.681665916778;6366.936330636634;6368.172137622079;6139.2019037526625;6272.749090036347;6352.047192921099;6359.491240700825;6370.108184854032;6142.508599311955;6184.690765461799;6191.690415479118;6193.225846769154;6196.318404975539;6401.583897046677;6406;6409.519286053658;6417.6470294132405;6428.164338635947;5963.880722385441;6093.482054025458;6190.969045154746;6227;6238 20:29:17 INFO - PROCESS | 8134 | |5;yui.html;688.9035535025096;705.6224919667977;732.3116270705536;847.1909326593096;855.7561095087901;14186.787198192036;14488.420463181461;14511.782323265146;14538.927305363459;16706.331746730117;14001.229932353717;14052.508162214324;14083.084599501026;14089.64775880601;14101.929490352533;645.9160309159803;828.4449418889359;838.8196537744384;847.7541512961234;851.4380508864151;847.6439895244013;849.2993280543545;850.306999795168;850.3622283287534;851.2126283188027;880.1374652840188;885.4819930340726;888.844452220862;888.9022207557196;890.7461373508552;688.2429327739496;857.939944203906;876.9649214031431;878.1306506558525;889.1597440418775;642.7686033028106;642.9421352078335;643.0803950350996;645.7675236914707;648.2901223160632;13906.096103753223;14016.509422170175;14039.227842468661;14073.225972571505;14088.859111408858;13393.598192054254;13439.664008399868;13585.116967397187;13606.795898061537;13739.175649461064;11411.60059397917;11582.94208528952;11755.235909665844;11848.725694634519;11867.228630139014;3790.166163444038;3796.658300752918;3801.3347664158937;3830.559485659157;3857.517810273716;54292.457075429134;54681.45318546803;54729.1790623145;54775;56994.430055699326;10737;10876.891231087746;11011.504482298316;11091.83362249567;11169.553217871357;17661.646767064587;17741.290348386177;17779.644407111784;17999.100044997696;18590.163442645113;8166.101728809826;8195.426320157532;8261.339092872557;8369.3304535637;8418.242358187792;4418.734875907456;4495.57292057254;4522.34426008227;4685.976570117127;4709.552592503706;3274.6397896231397;3286.359159963832;3287.7534184936226;3290.901272961815;3308.5202645616732;559.5299948043663;575.7322844877068;588.5821067042363;592.3365830270039;596.3470000349611;624.8125562331282;675.54103064844;691.7371398868398;710.7867639708066;715.0811207598211;8960.05919378469;9045.59294831721;9066.863997040049;9083.500407477652;9130.81738365229;538.3459097196925;610.4018062298971;624.2259598098416;628.3057221769969;634.0774173577433;4148.439960605279;4225.91548169041;4377.321515165155;4403.097365040159;4520.88697782558;65179.022314665315;65261;65648.6717566409;73512.63243683854;74941.62529187428;58634.413655862896;59499.405005950255;60171.39828601658;60341;60445.09332360018;51249.975000499784;52383.47616523786;54077;54498.455015450134;55292.723536382866;9000.819983600422;9087.863682044906;9136.360454768102;9185.540722963691;9254.35219534626;38507;39185.684776387076;39336.803315983234;39355.409668855566;40369;47318;47746.28380574225;47949;50395;51438.74280628573;11589.942050289694;11693.356865372147;11699;11938.76122477563;12053.397330133634;12211.450484728386;12547.372631368578;12711.555095571981;13037.413316400975;13278.601641950758;11937.701557461132;12229.388530573613;12260.448279827251;12265.202761820454;12334.321612311409;11741.530338786353;12144.514219431478;12345.197562158432;12441.37793110359;12635.052371072023;11814.173007889365;11993.220440671328;12150.867277139192;12156;12334.81497777552;9869.309148359545;9910.504474776377;9962.800743985224;10080.395176289447;10359.378437293786;9399.389039712396;9718.514074296398;9747.220222382051;9796.706098817047;9816.312858099864 20:29:17 INFO - PROCESS | 8134 | __end_tp_report 20:29:17 INFO - PROCESS | 8134 | __start_cc_report 20:29:17 INFO - PROCESS | 8134 | _x_x_mozilla_cycle_collect,808 20:29:17 INFO - PROCESS | 8134 | __end_cc_report 20:29:17 INFO - PROCESS | 8134 | __startTimestamp1458790157206__endTimestamp 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | ------- Summary: start ------- 20:29:17 INFO - PROCESS | 8134 | Number of tests: 6 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#0] dojo.html Cycles:165 Average:5146.40 Median:5309.00 stddev:576.97 (10.9%) stddev-sans-first:552.47 20:29:17 INFO - PROCESS | 8134 | Values: 2952.3 3035.6 3058.5 3086.3 3118.1 5095.5 5162.4 5209.9 5223.5 5253.7 5168.7 5183.7 5184.1 5191.6 5194.5 4647.7 4674.8 4791.7 4799.9 4826.4 4608.8 4753.0 4778.9 4796.3 4805.2 4683.1 4710.0 4713.2 4733.1 4750.5 4657.5 4667.0 4676.1 4689.1 4701.2 4540.8 4643.8 4657.5 4664.8 4714.0 5105.0 5114.6 5120.5 5124.6 5132.6 5524.9 5541.9 5548.0 5599.1 5599.3 5434.5 5485.4 5546.9 5549.8 5555.3 5223.3 5262.5 5266.6 5268.9 5271.5 5733.2 5734.8 5757.3 5757.9 5761.6 5375.7 5479.3 5496.4 5501.9 5539.7 5559.3 5565.8 5573.9 5573.9 5585.4 5374.7 5555.6 5556.0 5560.5 5613.4 5446.2 5474.8 5475.6 5491.8 5517.7 4245.9 4255.0 4263.6 4268.9 4299.6 3763.4 3794.4 3818.1 3839.6 3858.3 5117.4 5138.8 5144.0 5181.3 5191.4 5462.9 5502.3 5504.2 5515.7 5548.4 5079.8 5142.5 5153.1 5207.9 5308.8 4788.7 4805.4 4807.7 4815.5 4855.8 5777.5 5786.7 5793.6 5799.8 5800.2 5427.6 5521.1 5573.0 5682.9 5690.3 5734.6 5770.5 5770.7 5772.7 5782.3 5477.8 5489.2 5491.2 5494.9 5495.3 5461.5 5483.5 5516.0 5548.2 5565.2 5330.5 5354.7 5355.2 5363.1 5369.9 5309.0 5312.2 5341.1 5341.9 5383.2 5216.6 5227.5 5243.1 5243.5 5284.0 5426.9 5443.5 5456.3 5460.3 5471.8 5214.0 5293.6 5364.3 5407.3 5417.2 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#1] ext.html Cycles:180 Average:52294.25 Median:34926.65 stddev:92638.56 (265.2%) stddev-sans-first:92816.84 20:29:17 INFO - PROCESS | 8134 | Values: 510.4 554.9 560.2 583.9 595.6 30277.4 38684.2 39029.6 39062.6 39063.4 41809.8 42003.8 42267.6 42316.8 42381.8 7746.3 8581.1 8778.8 8787.0 10125.8 10176.1 10304.6 10309.2 10318.6 10334.3 10172.3 10327.6 10328.4 10329.7 10333.6 7988.9 10200.4 10365.6 10639.9 10648.8 10057.6 10088.8 10188.5 10192.1 10200.6 42264.8 42531.6 42586.0 42776.4 42833.6 3315.4 3388.4 3398.2 3557.3 3817.6 33061.0 33370.0 33418.0 33982.3 34110.5 4334.8 4353.9 4386.1 4414.8 4452.1 338914.0 341204.3 341348.0 342429.0 343310.0 63193.4 63495.8 63577.5 63684.4 63718.4 66535.0 66698.7 66747.7 66755.3 66766.3 16347.8 16810.6 16927.9 16956.7 16994.3 13317.8 13522.5 13555.5 13557.3 13557.7 19949.6 20627.3 21004.7 21062.5 21068.4 6382.0 7577.5 7739.3 7778.3 7858.5 987.0 1029.8 1066.5 1100.3 1212.8 28040.0 28382.0 28536.9 28643.0 28664.4 1167.9 1171.1 1203.9 1207.1 1260.1 14793.6 14851.3 15116.1 15322.2 15397.2 373582.0 380066.0 380390.0 380991.0 431146.0 50524.0 50815.2 51048.2 51071.2 51114.0 1392.4 1402.9 1407.2 1431.6 1438.9 27755.0 30201.7 31776.7 31802.4 31943.7 42923.8 42981.0 42988.6 42994.0 43054.6 316270.0 325681.0 326001.0 327295.0 327328.0 30612.0 34949.7 35484.5 35656.6 36114.6 41607.6 41795.4 42104.6 42249.8 42536.8 35356.0 35738.6 35777.6 36154.5 37051.8 35810.3 38078.4 38101.2 38103.0 38335.4 38458.8 40806.8 41227.0 41550.4 41690.8 32419.5 34903.7 35146.1 35599.8 35752.6 27095.6 27422.0 27446.7 27463.2 27840.3 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#2] jquery.html Cycles:180 Average:27933.41 Median:23018.04 stddev:79704.35 (346.3%) stddev-sans-first:79901.07 20:29:17 INFO - PROCESS | 8134 | Values: 365.2 369.7 369.7 372.4 378.7 17674.1 18001.0 18030.3 18385.7 18416.7 17144.8 17836.2 18429.9 18492.5 18588.1 5473.5 5601.3 5632.4 5636.0 5642.9 4098.5 5498.4 5823.3 6176.7 6197.9 6141.0 6155.3 6166.3 6179.8 6182.8 5928.3 6235.1 6235.3 6241.4 6241.6 3711.8 5263.1 5471.3 5485.9 5491.6 22887.5 23148.5 23274.9 23854.9 23887.0 2236.2 2366.3 2443.9 2612.9 2790.9 13685.0 13794.7 13808.7 13984.2 14240.6 1864.4 1917.5 1969.0 1979.1 1993.9 72030.6 73866.0 74690.6 74857.6 75970.0 10468.6 10565.2 10953.6 10974.9 11161.6 14366.3 14390.1 14395.8 14436.6 14449.3 8275.2 8607.1 8608.3 8748.6 8750.2 8683.1 8712.0 8735.7 8740.6 8804.8 6673.7 6681.9 6710.6 6750.6 6758.8 1745.3 1771.7 1790.0 1805.4 1818.2 967.7 1004.9 1010.1 1041.8 1049.7 19278.8 19285.2 19821.2 19965.2 20195.0 1053.3 1059.3 1089.8 1126.9 1143.3 10826.2 11285.3 11308.0 11337.4 11357.7 435048.0 445154.0 497046.0 521064.0 524324.0 79382.2 79588.0 80610.6 84190.6 84670.2 1063.6 1066.9 1096.0 1102.6 1104.7 16032.7 16055.0 16247.3 16259.8 16498.0 35475.8 35531.0 35713.1 36496.3 36683.3 45963.0 46242.5 46507.8 46624.0 46814.3 7778.8 7941.5 7946.1 7973.6 8026.6 11434.6 12375.4 12646.4 12664.9 13064.2 11185.3 11386.0 11494.9 11610.5 11940.1 11413.4 11413.7 11510.0 11613.4 11645.7 11241.6 11659.9 11670.8 11676.2 11780.7 7451.4 7810.4 7831.4 7984.4 8009.4 11395.7 11451.5 11553.8 11600.4 11714.2 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#3] mootools.html Cycles:180 Average:5655.41 Median:5515.03 stddev:2949.59 (53.5%) stddev-sans-first:2940.14 20:29:17 INFO - PROCESS | 8134 | Values: 1353.3 1475.9 1510.1 1684.9 1832.4 7845.1 7960.7 7987.0 8030.4 8037.0 7838.4 7967.5 7985.4 7998.7 8000.6 1993.2 2237.2 2244.9 2255.9 2306.3 2111.9 2145.1 2150.6 2152.3 2152.7 2221.5 2283.3 2284.8 2285.6 2288.9 2245.8 2267.5 2271.2 2293.1 2300.5 2217.0 2223.4 2244.4 2258.5 2259.5 7961.3 8030.0 8032.2 8032.6 8035.0 4935.5 5044.9 5046.5 5054.1 5060.1 3269.5 3272.7 3315.8 3326.7 3357.1 1039.0 2102.2 2193.6 2196.2 2198.4 10904.1 11071.3 11092.8 11094.1 11098.9 4257.4 4407.3 4414.7 4442.3 4445.4 9583.7 9609.7 9625.2 9638.2 9641.8 4551.8 5026.0 5026.5 5028.7 5103.6 4472.3 4550.6 4576.9 4621.4 4625.9 3809.2 3890.5 3898.4 3916.7 3945.9 1144.2 1187.0 1189.8 1198.5 1207.6 1317.7 1335.7 1348.8 1385.6 1386.3 7543.8 7591.5 7635.4 7641.4 7643.1 437.6 447.3 449.9 451.9 453.2 5926.4 5951.7 5964.0 5983.6 5991.7 9499.0 9961.0 9971.4 10094.7 10108.2 9963.9 10023.5 10023.7 10048.2 10065.2 7463.6 7765.7 7787.0 7839.7 7862.8 7078.2 7124.0 7140.4 7147.0 7151.4 8500.7 8918.8 8997.8 9110.6 9114.5 8737.0 8762.8 8948.1 8950.5 8993.4 6502.7 6670.2 7002.1 7211.1 7321.3 7745.1 7751.0 7753.5 7792.2 7794.1 6813.3 7042.2 7042.5 7138.0 7142.6 6896.3 7000.3 7031.4 7032.2 7105.4 7090.8 7091.7 7245.0 7395.5 7403.5 6555.2 6578.7 6602.8 6608.9 6630.0 6305.4 6334.9 6345.0 6415.6 6539.1 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#4] prototype.html Cycles:180 Average:5231.89 Median:5933.32 stddev:1625.03 (27.4%) stddev-sans-first:1586.99 20:29:17 INFO - PROCESS | 8134 | Values: 307.3 313.2 318.6 320.9 325.0 5893.0 5918.9 5919.9 5930.2 5934.6 5804.4 5829.4 5913.9 5920.8 5932.0 4265.6 4356.6 4364.0 4428.1 4460.2 4422.4 4460.5 4464.5 4465.0 4471.6 4404.1 4410.8 4413.1 4415.6 4420.9 4239.9 4306.8 4398.3 4409.9 4412.6 3829.1 3831.6 3837.6 3839.8 3844.4 5683.2 5689.3 5692.3 5697.3 5699.5 5159.4 5169.2 5176.0 5176.5 5185.6 6194.4 6215.2 6217.5 6219.5 6224.0 4065.9 4195.1 4202.2 4307.9 4308.4 6510.2 6544.5 6546.9 6573.5 6577.7 4298.8 4301.1 4301.2 4302.2 4307.4 4364.8 4368.0 4368.3 4368.3 4376.3 5104.6 5108.3 5113.5 5118.4 5121.6 6122.1 6302.2 6308.9 6312.7 6315.4 1518.2 1528.3 1536.2 1538.0 1539.3 942.3 994.3 998.9 1003.0 1016.0 5881.9 5899.3 5940.3 5949.2 5949.8 6403.8 6434.9 6438.2 6438.5 6448.1 5912.9 5926.3 5928.1 5937.4 5943.6 3450.1 3476.7 3483.5 3486.8 3499.8 6621.5 6674.9 6705.2 6862.3 6876.2 6692.9 6717.3 6718.2 6722.6 6733.2 6836.7 6841.1 6841.7 6844.9 6845.6 6576.5 6581.6 6584.4 6590.6 6593.4 6285.0 6434.8 6487.0 6515.8 6517.4 6764.6 6873.7 6897.2 6900.8 6913.9 4439.4 4476.4 4477.8 4480.6 4483.1 6517.7 6517.9 6524.9 6533.8 6534.9 6353.6 6354.5 6366.7 6366.9 6368.2 6139.2 6272.7 6352.0 6359.5 6370.1 6142.5 6184.7 6191.7 6193.2 6196.3 6401.6 6406.0 6409.5 6417.6 6428.2 5963.9 6093.5 6191.0 6227.0 6238.0 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - PROCESS | 8134 | [#5] yui.html Cycles:180 Average:15354.92 Median:50822.49 stddev:18562.66 (36.5%) stddev-sans-first:18582.06 20:29:17 INFO - PROCESS | 8134 | Values: 688.9 705.6 732.3 847.2 855.8 14186.8 14488.4 14511.8 14538.9 16706.3 14001.2 14052.5 14083.1 14089.6 14101.9 645.9 828.4 838.8 847.8 851.4 847.6 849.3 850.3 850.4 851.2 880.1 885.5 888.8 888.9 890.7 688.2 857.9 877.0 878.1 889.2 642.8 642.9 643.1 645.8 648.3 13906.1 14016.5 14039.2 14073.2 14088.9 13393.6 13439.7 13585.1 13606.8 13739.2 11411.6 11582.9 11755.2 11848.7 11867.2 3790.2 3796.7 3801.3 3830.6 3857.5 54292.5 54681.5 54729.2 54775.0 56994.4 10737.0 10876.9 11011.5 11091.8 11169.6 17661.6 17741.3 17779.6 17999.1 18590.2 8166.1 8195.4 8261.3 8369.3 8418.2 4418.7 4495.6 4522.3 4686.0 4709.6 3274.6 3286.4 3287.8 3290.9 3308.5 559.5 575.7 588.6 592.3 596.3 624.8 675.5 691.7 710.8 715.1 8960.1 9045.6 9066.9 9083.5 9130.8 538.3 610.4 624.2 628.3 634.1 4148.4 4225.9 4377.3 4403.1 4520.9 65179.0 65261.0 65648.7 73512.6 74941.6 58634.4 59499.4 60171.4 60341.0 60445.1 51250.0 52383.5 54077.0 54498.5 55292.7 9000.8 9087.9 9136.4 9185.5 9254.4 38507.0 39185.7 39336.8 39355.4 40369.0 47318.0 47746.3 47949.0 50395.0 51438.7 11589.9 11693.4 11699.0 11938.8 12053.4 12211.5 12547.4 12711.6 13037.4 13278.6 11937.7 12229.4 12260.4 12265.2 12334.3 11741.5 12144.5 12345.2 12441.4 12635.1 11814.2 11993.2 12150.9 12156.0 12334.8 9869.3 9910.5 9962.8 10080.4 10359.4 9399.4 9718.5 9747.2 9796.7 9816.3 20:29:17 INFO - PROCESS | 8134 | -------- Summary: end -------- 20:29:17 INFO - PROCESS | 8134 | 20:29:17 INFO - TEST-INFO | 8134: exit 0 20:29:17 INFO - TEST-OK | dromaeo_css | took 1110979ms 20:29:17 INFO - TEST-START | kraken 20:29:17 INFO - operating with platform_type : linux_ 20:29:17 INFO - Initialising browser for kraken test... 20:29:17 INFO - TEST-INFO | started process 8321 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Y9V4_/profile http://localhost:44040/getInfo.html) 20:29:22 INFO - PROCESS | 8321 | __metrics Screen width/height:1600/1200 20:29:22 INFO - PROCESS | 8321 | colorDepth:24 20:29:22 INFO - PROCESS | 8321 | Browser inner width/height: 1024/697 20:29:22 INFO - PROCESS | 8321 | __metrics 20:29:23 ERROR - PROCESS | 8321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:29:23 INFO - PROCESS | 8321 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:29:23 INFO - TEST-INFO | 8321: exit 0 20:29:23 INFO - Browser initialized. 20:29:23 INFO - Running cycle 1/1 for kraken test... 20:29:23 INFO - TEST-INFO | started process 8404 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Y9V4_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:35 INFO - PROCESS | 8404 | RSS: Main: 156233728 20:29:35 INFO - PROCESS | 8404 | 20:29:38 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44040/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:38 INFO - PROCESS | 8404 | RSS: Main: 199520256 20:29:38 INFO - PROCESS | 8404 | 20:29:41 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44040/tests/kraken/driver.html?testName=audio-dft) 20:29:42 INFO - PROCESS | 8404 | RSS: Main: 187555840 20:29:42 INFO - PROCESS | 8404 | 20:29:44 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44040/tests/kraken/driver.html?testName=audio-fft) 20:29:45 INFO - PROCESS | 8404 | RSS: Main: 171139072 20:29:45 INFO - PROCESS | 8404 | 20:29:47 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44040/tests/kraken/driver.html?testName=audio-oscillator) 20:29:48 INFO - PROCESS | 8404 | RSS: Main: 173232128 20:29:48 INFO - PROCESS | 8404 | 20:29:50 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44040/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:50 INFO - PROCESS | 8404 | RSS: Main: 175300608 20:29:50 INFO - PROCESS | 8404 | 20:29:53 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44040/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:54 INFO - PROCESS | 8404 | RSS: Main: 175812608 20:29:54 INFO - PROCESS | 8404 | 20:29:57 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44040/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:58 INFO - PROCESS | 8404 | RSS: Main: 176177152 20:29:58 INFO - PROCESS | 8404 | 20:30:01 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44040/tests/kraken/driver.html?testName=json-parse-financial) 20:30:01 INFO - PROCESS | 8404 | RSS: Main: 176721920 20:30:01 INFO - PROCESS | 8404 | 20:30:03 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44040/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:30:03 INFO - PROCESS | 8404 | RSS: Main: 187637760 20:30:03 INFO - PROCESS | 8404 | 20:30:05 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:06 INFO - PROCESS | 8404 | RSS: Main: 184647680 20:30:06 INFO - PROCESS | 8404 | 20:30:08 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:30:08 INFO - PROCESS | 8404 | RSS: Main: 194420736 20:30:08 INFO - PROCESS | 8404 | 20:30:11 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:11 INFO - PROCESS | 8404 | RSS: Main: 203526144 20:30:11 INFO - PROCESS | 8404 | 20:30:14 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:14 INFO - PROCESS | 8404 | RSS: Main: 200798208 20:30:14 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | Cycle 1(1): loaded http://localhost:44040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44040/tests/kraken/driver.html?testName=ai-astar) 20:30:16 INFO - PROCESS | 8404 | RSS: Main: 262791168 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | __start_tp_report 20:30:16 INFO - PROCESS | 8404 | _x_x_mozilla_page_load 20:30:16 INFO - PROCESS | 8404 | _x_x_mozilla_page_load_details 20:30:16 INFO - PROCESS | 8404 | |i|pagename|runs| 20:30:16 INFO - PROCESS | 8404 | |0;ai-astar;110;111;108;111;112;111;101;111;112;111 20:30:16 INFO - PROCESS | 8404 | |1;audio-beat-detection;152;127;150;170;130;147;150;143;168;125 20:30:16 INFO - PROCESS | 8404 | |2;audio-dft;161;161;161;161;161;163;160;163;161;162 20:30:16 INFO - PROCESS | 8404 | |3;audio-fft;76;73;105;91;72;75;72;103;100;75 20:30:16 INFO - PROCESS | 8404 | |4;audio-oscillator;94;93;144;97;93;95;138;94;93;148 20:30:16 INFO - PROCESS | 8404 | |5;imaging-gaussian-blur;117;118;117;116;117;118;117;117;117;117 20:30:16 INFO - PROCESS | 8404 | |6;imaging-darkroom;146;144;146;146;147;146;146;146;145;145 20:30:16 INFO - PROCESS | 8404 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;95;95 20:30:16 INFO - PROCESS | 8404 | |8;json-parse-financial;57;57;56;56;58;57;56;66;54;54 20:30:16 INFO - PROCESS | 8404 | |9;json-stringify-tinderbox;58;60;60;60;60;60;60;60;59;60 20:30:16 INFO - PROCESS | 8404 | |10;stanford-crypto-aes;76;78;77;79;78;77;78;77;80;77 20:30:16 INFO - PROCESS | 8404 | |11;stanford-crypto-ccm;111;109;108;114;116;112;109;113;118;116 20:30:16 INFO - PROCESS | 8404 | |12;stanford-crypto-pbkdf2;141;141;141;141;141;143;140;140;139;139 20:30:16 INFO - PROCESS | 8404 | |13;stanford-crypto-sha256-iterative;66;63;65;64;62;61;62;62;63;64 20:30:16 INFO - PROCESS | 8404 | __end_tp_report 20:30:16 INFO - PROCESS | 8404 | __start_cc_report 20:30:16 INFO - PROCESS | 8404 | _x_x_mozilla_cycle_collect,1045 20:30:16 INFO - PROCESS | 8404 | __end_cc_report 20:30:16 INFO - PROCESS | 8404 | __startTimestamp1458790216668__endTimestamp 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | ------- Summary: start ------- 20:30:16 INFO - PROCESS | 8404 | Number of tests: 14 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.29 (3.0%) stddev-sans-first:3.49 20:30:16 INFO - PROCESS | 8404 | Values: 110.0 111.0 108.0 111.0 112.0 111.0 101.0 111.0 112.0 111.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:150.00 stddev:15.62 (10.4%) stddev-sans-first:16.42 20:30:16 INFO - PROCESS | 8404 | Values: 152.0 127.0 150.0 170.0 130.0 147.0 150.0 143.0 168.0 125.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 20:30:16 INFO - PROCESS | 8404 | Values: 161.0 161.0 161.0 161.0 161.0 163.0 160.0 163.0 161.0 162.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#3] audio-fft Cycles:10 Average:84.20 Median:74.00 stddev:13.91 (18.8%) stddev-sans-first:14.43 20:30:16 INFO - PROCESS | 8404 | Values: 76.0 73.0 105.0 91.0 72.0 75.0 72.0 103.0 100.0 75.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.50 stddev:23.91 (25.6%) stddev-sans-first:24.74 20:30:16 INFO - PROCESS | 8404 | Values: 94.0 93.0 144.0 97.0 93.0 95.0 138.0 94.0 93.0 148.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:30:16 INFO - PROCESS | 8404 | Values: 117.0 118.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:30:16 INFO - PROCESS | 8404 | Values: 146.0 144.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 145.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:30:16 INFO - PROCESS | 8404 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.38 (5.9%) stddev-sans-first:3.59 20:30:16 INFO - PROCESS | 8404 | Values: 57.0 57.0 56.0 56.0 58.0 57.0 56.0 66.0 54.0 54.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 20:30:16 INFO - PROCESS | 8404 | Values: 58.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:1.16 (1.5%) stddev-sans-first:1.05 20:30:16 INFO - PROCESS | 8404 | Values: 76.0 78.0 77.0 79.0 78.0 77.0 78.0 77.0 80.0 77.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#11] stanford-crypto-ccm Cycles:10 Average:112.60 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:3.56 20:30:16 INFO - PROCESS | 8404 | Values: 111.0 109.0 108.0 114.0 116.0 112.0 109.0 113.0 118.0 116.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:141.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 20:30:16 INFO - PROCESS | 8404 | Values: 141.0 141.0 141.0 141.0 141.0 143.0 140.0 140.0 139.0 139.0 20:30:16 INFO - PROCESS | 8404 | 20:30:16 INFO - PROCESS | 8404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.27 20:30:16 INFO - PROCESS | 8404 | Values: 66.0 63.0 65.0 64.0 62.0 61.0 62.0 62.0 63.0 64.0 20:30:16 INFO - PROCESS | 8404 | -------- Summary: end -------- 20:30:16 INFO - PROCESS | 8404 | 20:30:17 INFO - TEST-INFO | 8404: exit 0 20:30:17 INFO - TEST-OK | kraken | took 59947ms 20:30:17 INFO - SUITE-END | took 1170s 20:30:18 INFO - Completed test suite (00:19:31) 20:30:18 INFO - javascript benchmark 20:30:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2952.2766922104083, 3035.635723713152, 3058.525928481085, 3086.2747254395213, 3118.0645806258117, 5095.490450954902, 5162.38051433828, 5209.86975325617, 5223.5037671421205, 5253.658512196705, 5168.689878607277, 5183.663061900983, 5184.092783762836, 5191.5846732261425, 5194.506521880416, 4647.651426143036, 4674.813007479696, 4791.736454495001, 4799.928001079987, 4826.444958829727, 4608.838690645828, 4752.9762351188365, 4778.928316075262, 4796.25658023007, 4805.231163013918, 4683.063387322549, 4710.010897711485, 4713.198756211452, 4733.124371991158, 4750.548697873696, 4657.4876763555985, 4667.0, 4676.064787042571, 4689.085628302482, 4701.247800351927, 4540.818367265306, 4643.8142474300985, 4657.487676355632, 4664.790084446208, 4714.033623107289, 5105.0, 5114.565261952738, 5120.539151476348, 5124.615653825941, 5132.589392848563, 5524.944750552523, 5541.861453463655, 5548.029094908375, 5599.132134519156, 5599.272094627713, 5434.538064264542, 5485.396606373296, 5546.861328466821, 5549.77800887964, 5555.2778138842095, 5223.3209682741, 5262.473752624707, 5266.631335806495, 5268.894622107537, 5271.499207575274, 5733.226014488074, 5734.77060917567, 5757.280339957505, 5757.8560535986935, 5761.567882408836, 5375.6774593524515, 5479.315085614298, 5496.367917689517, 5501.9174712379345, 5539.695316757537, 5559.33288005442, 5565.777368905279, 5573.888522229533, 5573.916391254134, 5585.357683866326, 5374.677519348852, 5555.583331250092, 5556.0, 5560.527355174774, 5613.382527921925, 5446.2375267462585, 5474.753636086386, 5475.589330800206, 5491.780328786884, 5517.724113794295, 4245.8513952011535, 4255.021345090647, 4263.637590804817, 4268.87193384199, 4299.570042995675, 3763.360228761117, 3794.392897136445, 3818.0836599216545, 3839.6352346527037, 3858.3247931611854, 5117.41149767774, 5138.768755406016, 5143.974280128576, 5181.274621552986, 5191.377034755854, 5462.863428414242, 5502.339719233718, 5504.174373843955, 5515.669059856422, 5548.389677135512, 5079.847604571869, 5142.51146141116, 5153.123968925292, 5207.921881171786, 5308.814191503279, 4788.7366194859615, 4805.447373552016, 4807.711537307773, 4815.470298267188, 4855.757212139379, 5777.537796976232, 5786.652800831964, 5793.623414478046, 5799.768009279666, 5800.187973683687, 5427.6200665953, 5521.1442226454965, 5572.972135139217, 5682.886342273048, 5690.317161940594, 5734.59857809966, 5770.451807078321, 5770.740316685676, 5772.711364431846, 5782.306123265235, 5477.75350109254, 5489.204065410573, 5491.2312276282155, 5494.890102197854, 5495.258140151029, 5461.5357694596405, 5483.479069488392, 5516.0, 5548.195511650869, 5565.165225216088, 5330.466953304638, 5354.705491198021, 5355.2234925934745, 5363.115086010921, 5369.946300537101, 5309.0, 5312.203169524448, 5341.065313570188, 5341.893162136813, 5383.16560933056, 5216.634835561475, 5227.503387178212, 5243.134882744457, 5243.475652434726, 5283.996040752245, 5426.860359324586, 5443.455654434525, 5456.263404440349, 5460.290162278879, 5471.8084867029465, 5214.0, 5293.602979776455, 5364.302640656846, 5407.297051383295, 5417.214503896992], "unit": "score", "name": "dojo.html", "value": 5108.327833161099}, {"lowerIsBetter": false, "replicates": [510.39773067780004, 554.8973439913614, 560.218495199197, 583.9357670656228, 595.6009473652655, 30277.394452110973, 38684.22631547367, 39029.609703902956, 39062.60937390625, 39063.41404878926, 41809.79095104528, 42003.789981050126, 42267.577324226746, 42316.788416057876, 42381.78809105958, 7746.264104910025, 8581.098984606604, 8778.780530486756, 8786.956065219665, 10125.797484050314, 10176.08415242628, 10304.639337623184, 10309.226807989393, 10318.58725650973, 10334.276600637959, 10172.338797978146, 10327.58689652413, 10328.431936243504, 10329.741756456073, 10333.586656533767, 7988.920110798905, 10200.387976721384, 10365.585376584928, 10639.893601063968, 10648.840267395995, 10057.647982320585, 10088.848667269996, 10188.541515631814, 10192.133668638175, 10200.591976320939, 42264.78867605642, 42531.57468425307, 42586.0, 42776.3583546247, 42833.57166428327, 3315.353506066318, 3388.3562123196516, 3398.201422665696, 3557.324108419418, 3817.5800661927165, 33061.0, 33370.0, 33418.0, 33982.32035359279, 34110.48834267488, 4334.783260836945, 4353.891152721176, 4386.144701783153, 4414.845480408202, 4452.109578084363, 338914.0, 341204.29397853103, 341348.0, 342429.0, 343310.0, 63193.36806631875, 63495.7776477821, 63577.50323732146, 63684.36315636784, 63718.36281637124, 66535.0, 66698.66650666813, 66747.66626166838, 66755.33244667492, 66766.33233667698, 16347.836521634868, 16810.57973550671, 16927.915360423118, 16956.660866782597, 16994.32022719102, 13317.800232996513, 13522.459101636021, 13555.52555660567, 13557.322133893265, 13557.728845423233, 19949.60100798005, 20627.278045268344, 21004.684929726067, 21062.473438163863, 21068.367948961557, 6381.968090159519, 7577.507462014952, 7739.264769846855, 7778.299953004257, 7858.528488290721, 987.0425687083517, 1029.7951396865685, 1066.461436974323, 1100.339796122336, 1212.8241404996402, 28040.0, 28382.0, 28536.85731571329, 28643.0, 28664.426711466072, 1167.8948894599357, 1171.0982543441503, 1203.9337836418906, 1207.1368971185645, 1260.1368062876775, 14793.556193314218, 14851.331690073972, 15116.09303441797, 15322.23388830554, 15397.23013849303, 373582.0, 380066.0, 380390.0, 380991.0, 431146.0, 50524.0, 50815.23777143346, 51048.234276485884, 51071.23393149106, 51114.0, 1392.352556061416, 1402.922839243831, 1407.176801571072, 1431.6492459347526, 1438.9424423022963, 27755.0, 30201.697983019887, 31776.682233177373, 31802.36395272128, 31943.680563195, 42923.78538107414, 42981.0, 42988.570114298454, 42994.0, 43054.569454305056, 316270.0, 325681.0, 326001.0, 327295.0, 327328.0, 30612.0, 34949.65050349566, 35484.46773298351, 35656.64343356533, 36114.63885361218, 41607.58392416037, 41795.37306940459, 42104.57895421007, 42249.78875105605, 42536.78731606322, 35356.0, 35738.64261357353, 35777.64222357743, 36154.4576831353, 37051.81474092612, 35810.28379432449, 38078.428823568225, 38101.237975240896, 38103.0, 38335.42496862494, 38458.80770596129, 40806.79596601998, 41227.0, 41550.37674434826, 41690.79154604329, 32419.513707293936, 34903.650963491054, 35146.121346965505, 35599.82200088983, 35752.64247357493, 27095.59356609692, 27422.0, 27446.725532744418, 27463.17610471689, 27840.303992400353], "unit": "score", "name": "ext.html", "value": 19799.22813468931}, {"lowerIsBetter": false, "replicates": [365.2166103707547, 369.6950016236604, 369.73009702916886, 372.3614001986592, 378.7065024605932, 17674.11629418529, 18001.0, 18030.27878884843, 18385.724214136797, 18416.723749143774, 17144.82855171448, 17836.197371118298, 18429.907850460728, 18492.537686557844, 18588.07059647019, 5473.534749546293, 5601.327840659126, 5632.408597097307, 5635.971820140893, 5642.943570564283, 4098.4671992640915, 5498.422665620113, 5823.3012038555435, 6176.691165441733, 6197.938020619804, 6141.0, 6155.26136863577, 6166.321704612489, 6179.7837075702355, 6182.752689892422, 5928.288605367362, 6235.127082208472, 6235.345288744707, 6241.438270555626, 6241.594296370744, 3711.8329675164414, 5263.105272103713, 5471.288732464794, 5485.890282194374, 5491.643043202219, 22887.54224915509, 23148.53702925949, 23274.883625581933, 23854.88072559626, 23887.0, 2236.2396785092983, 2366.3137690069857, 2443.9389015274583, 2612.9216123516326, 2790.8696977724053, 13685.0, 13794.65513362164, 13808.723825523533, 13984.163635823088, 14240.643983900485, 1864.4499872537633, 1917.4631103291101, 1968.9507762305914, 1979.0995097230868, 1993.880367177974, 72030.63984680043, 73865.99999999946, 74690.62654686747, 74857.6257118711, 75970.0, 10468.633597824191, 10565.200221941192, 10953.616623418142, 10974.945125274322, 11161.609343672932, 14366.281685915872, 14390.136591804525, 14395.78406323906, 14436.639084022774, 14449.34977925996, 8275.213854683796, 8607.139286071342, 8608.268297194683, 8748.562571871382, 8750.168733970262, 8683.108468975737, 8712.041675415827, 8735.650573977096, 8740.562971851383, 8804.823903521894, 6673.666316684146, 6681.930891057407, 6710.630915299607, 6750.594964302158, 6758.797236082925, 1745.2844333823073, 1771.6988112020988, 1789.9642007159784, 1805.3590975203876, 1818.1818181818078, 967.7000129959595, 1004.8643433136433, 1010.0707349238718, 1041.8072656558409, 1049.7375656085978, 19278.807211927702, 19285.228590856488, 19821.20715171377, 19965.20139194416, 20195.0, 1053.3153450257394, 1059.279689810936, 1089.8310761831929, 1126.920547617613, 1143.279733767721, 10826.188035897181, 11285.322880627024, 11308.0, 11337.43312834355, 11357.716057098638, 435048.0, 445154.0, 497046.0, 521064.0, 524324.0, 79382.20617793864, 79588.0, 80610.59694701488, 84190.57904710437, 84670.22284261453, 1063.5958335832333, 1066.9253152279266, 1096.0245381610532, 1102.6361300770727, 1104.690686607751, 16032.679346412773, 16055.0, 16247.268872900984, 16259.837401625833, 16498.0, 35475.82262088673, 35531.0, 35713.1071723209, 36496.27007459889, 36683.26633467369, 45963.0, 46242.53757462382, 46507.767461162475, 46624.0, 46814.29778553393, 7778.766637000899, 7941.523508589503, 7946.125926148004, 7973.561454119847, 8026.558539280396, 11434.599789007345, 12375.381230938598, 12646.367681616066, 12664.936675316932, 13064.150830196008, 11185.272957257752, 11386.0, 11494.885051149717, 11610.535578576762, 11940.104492163297, 11413.372264525531, 11413.714657133638, 11510.0, 11613.3612651305, 11645.6506304811, 11241.550337986717, 11659.88340116588, 11670.824937625772, 11676.182667213554, 11780.70548236301, 7451.40388768908, 7810.414218933716, 7831.373490120891, 7984.361251099782, 8009.399295053011, 11395.658130256106, 11451.48468318911, 11553.768924621629, 11600.361980091177, 11714.23857449263], "unit": "score", "name": "jquery.html", "value": 9188.905790807969}, {"lowerIsBetter": false, "replicates": [1353.3165751295594, 1475.9188244646543, 1510.10148961368, 1684.949451516455, 1832.3586744639379, 7845.09781375142, 7960.7213747518845, 7987.0, 8030.397720170996, 8037.0, 7838.412119091063, 7967.521948683083, 7985.40109491789, 7998.720044798433, 8000.639971201295, 1993.1628715939269, 2237.2281562860785, 2244.876531790751, 2255.875926824024, 2306.261996161229, 2111.9049642766113, 2145.0561752828708, 2150.580636775829, 2152.278986539511, 2152.698622192894, 2221.466847956487, 2283.3264187064856, 2284.817214622826, 2285.5771682238756, 2288.9198878039274, 2245.7978781909624, 2267.478479949604, 2271.159670921753, 2293.094227780026, 2300.470891694911, 2216.9778302216932, 2223.433024578722, 2244.3827947314458, 2258.5482903419384, 2259.548090381914, 7961.323287520568, 8030.036395632562, 8032.1566235545015, 8032.558209298486, 8034.9598252008955, 4935.481774413706, 5044.899102017976, 5046.495350464924, 5054.115529782273, 5060.063888180698, 3269.53150371468, 3272.689094536039, 3315.8176300303476, 3326.6839650233187, 3357.143928298293, 1039.0285083447002, 2102.1591363454586, 2193.5941850757663, 2196.1983875885185, 2198.428408613756, 10904.07315378186, 11071.280366776135, 11092.778144437147, 11094.1124710023, 11098.944505277503, 4257.446531950888, 4407.338899165151, 4414.668899832525, 4442.267025940748, 4445.444319460067, 9583.712488625353, 9609.663661771805, 9625.181859541877, 9638.180754635794, 9641.758956026155, 4551.8179272829375, 5026.045051440215, 5026.547610715053, 5028.673136246132, 5103.642745007888, 4472.284434490531, 4550.635949124062, 4576.88557786058, 4621.445426548836, 4625.907481850344, 3809.2000679857542, 3890.5331360236387, 3898.3762597984187, 3916.7258291919293, 3945.921081578352, 1144.1876267849752, 1187.0, 1189.7679952409196, 1198.484651599803, 1207.6256360528089, 1317.7496275707585, 1335.7128217433103, 1348.8246527951303, 1385.6189547874415, 1386.2583517817918, 7543.811404714926, 7591.4685971981435, 7635.350995165473, 7641.3886889048745, 7643.121041080236, 437.6236436664466, 447.2642503082411, 449.93925820014533, 451.907358991406, 453.2391658407112, 5926.407359264039, 5951.672658003765, 5964.0, 5983.551233657493, 5991.730372133265, 9498.95250523743, 9960.950195248977, 9971.351862128939, 10094.747631309128, 10108.24188185889, 9963.850542241873, 10023.548940297704, 10023.749406264902, 10048.246381521416, 10065.245106617032, 7463.589502577411, 7765.650545725456, 7787.0, 7839.686412543434, 7862.842743145219, 7078.221395646372, 7124.0, 7140.393066589398, 7147.0, 7151.4278857690215, 8500.659973600987, 8918.777030574287, 8997.820043599222, 9110.590023449093, 9114.544272786201, 8737.038925718292, 8762.780930476789, 8948.105189481, 8950.462972221687, 8993.415427997159, 6502.6748662567625, 6670.166229221348, 7002.124734408199, 7211.098612673416, 7321.341079302888, 7745.148033716399, 7751.0, 7753.534787912743, 7792.220777922389, 7794.064712234568, 6813.250542440229, 7042.190148132825, 7042.542234754725, 7138.0363650906465, 7142.607156606437, 6896.310368963063, 7000.334968178015, 7031.40233080194, 7032.156141263081, 7105.431565474646, 7090.822729431806, 7091.716331346688, 7245.021922040457, 7395.519291246267, 7403.481756277224, 6555.2133743951035, 6578.671066446755, 6602.801915942529, 6608.933910660832, 6630.038644396439, 6305.369463053658, 6334.9366506334345, 6345.0482427636225, 6415.550911436155, 6539.149910511603], "unit": "score", "name": "mootools.html", "value": 4591.242701332158}, {"lowerIsBetter": false, "replicates": [307.33308720077434, 313.1638525137882, 318.64789407704484, 320.9374172036454, 325.04599001929324, 5893.0, 5918.881622367556, 5919.940800591993, 5930.229070220876, 5934.643921364721, 5804.448577385152, 5829.446202610745, 5913.881722365551, 5920.75011495631, 5932.0, 4265.594768496995, 4356.629686476654, 4363.978180109111, 4428.114377124572, 4460.1525710114975, 4422.402975598301, 4460.531644177363, 4464.531224221459, 4464.955350446503, 4471.642268618502, 4404.053128577355, 4410.80151393188, 4413.117376524708, 4415.602595766381, 4420.9336859947125, 4239.872803815875, 4306.7631280279575, 4398.252297109499, 4409.867703968886, 4412.558744125594, 3829.0810205550747, 3831.63599458051, 3837.597052309495, 3839.8464061437508, 3844.442555829389, 5683.175939488751, 5689.345725241567, 5692.345380281279, 5697.259356283656, 5699.458551437607, 5159.406668233164, 5169.198774190007, 5176.016556854186, 5176.50823171798, 5185.585153187736, 6194.4425001749605, 6215.192025036717, 6217.502599792006, 6219.533534984895, 6224.0, 4065.8983525411804, 4195.098053918392, 4202.159568086395, 4307.870763877088, 4308.3537469379535, 6510.18622672166, 6544.476441884638, 6546.869062618721, 6573.474122070271, 6577.6711164441585, 4298.763568003727, 4301.139772045541, 4301.2257793597455, 4302.247106756305, 4307.375430562551, 4364.803583838735, 4368.0, 4368.27923392643, 4368.322909948963, 4376.256036473807, 5104.617153713486, 5108.259302401131, 5113.463086375951, 5118.38579370478, 5121.590272778169, 6122.081687746873, 6302.180716506825, 6308.89594320992, 6312.652804095819, 6315.431611155018, 1518.2105305241212, 1528.3122594832148, 1536.2011753887916, 1537.9692406151814, 1539.2996186735008, 942.2697409507687, 994.2692121290845, 998.9100980911753, 1002.9949850250702, 1016.0499932563077, 5881.941180588225, 5899.321578018497, 5940.257467816523, 5949.167116603679, 5949.762009519657, 6403.807885763435, 6434.935650643527, 6438.195225596801, 6438.517111216677, 6448.1295025171, 5912.940870591325, 5926.259217597801, 5928.140419639129, 5937.376575459514, 5943.613665111754, 3450.1202193440513, 3476.687098161178, 3483.512308276843, 3486.790792552455, 3499.825008749552, 6621.470282377399, 6674.866502670016, 6705.228898676617, 6862.279460656659, 6876.209235937831, 6692.899606505906, 6717.261101278856, 6718.193816741925, 6722.630255336004, 6733.158355205599, 6836.726530938707, 6841.144856892888, 6841.657917104224, 6844.863102737917, 6845.623490708059, 6576.506761992774, 6581.605103693793, 6584.407403333723, 6590.604563726191, 6593.3736295051895, 6284.968575157095, 6434.806955791334, 6486.967565162144, 6515.804525864231, 6517.4134327910715, 6764.594124352555, 6873.725050997904, 6897.206821215424, 6900.758473453405, 6913.93086069153, 4439.356293337512, 4476.4180656514445, 4477.776111194493, 4480.551944805624, 4483.125790470827, 6517.674116294261, 6517.902231466626, 6524.869502610016, 6533.771318003847, 6534.901976470262, 6353.555251132377, 6354.4916406686425, 6366.681665916778, 6366.936330636634, 6368.172137622079, 6139.2019037526625, 6272.749090036347, 6352.047192921099, 6359.491240700825, 6370.108184854032, 6142.508599311955, 6184.690765461799, 6191.690415479118, 6193.225846769154, 6196.318404975539, 6401.583897046677, 6406.0, 6409.519286053658, 6417.6470294132405, 6428.164338635947, 5963.880722385441, 6093.482054025458, 6190.969045154746, 6227.0, 6238.0], "unit": "score", "name": "prototype.html", "value": 4693.29338708316}, {"lowerIsBetter": false, "replicates": [688.9035535025096, 705.6224919667977, 732.3116270705536, 847.1909326593096, 855.7561095087901, 14186.787198192036, 14488.420463181461, 14511.782323265146, 14538.927305363459, 16706.331746730117, 14001.229932353717, 14052.508162214324, 14083.084599501026, 14089.64775880601, 14101.929490352533, 645.9160309159803, 828.4449418889359, 838.8196537744384, 847.7541512961234, 851.4380508864151, 847.6439895244013, 849.2993280543545, 850.306999795168, 850.3622283287534, 851.2126283188027, 880.1374652840188, 885.4819930340726, 888.844452220862, 888.9022207557196, 890.7461373508552, 688.2429327739496, 857.939944203906, 876.9649214031431, 878.1306506558525, 889.1597440418775, 642.7686033028106, 642.9421352078335, 643.0803950350996, 645.7675236914707, 648.2901223160632, 13906.096103753223, 14016.509422170175, 14039.227842468661, 14073.225972571505, 14088.859111408858, 13393.598192054254, 13439.664008399868, 13585.116967397187, 13606.795898061537, 13739.175649461064, 11411.60059397917, 11582.94208528952, 11755.235909665844, 11848.725694634519, 11867.228630139014, 3790.166163444038, 3796.658300752918, 3801.3347664158937, 3830.559485659157, 3857.517810273716, 54292.457075429134, 54681.45318546803, 54729.1790623145, 54775.0, 56994.430055699326, 10737.0, 10876.891231087746, 11011.504482298316, 11091.83362249567, 11169.553217871357, 17661.646767064587, 17741.290348386177, 17779.644407111784, 17999.100044997696, 18590.163442645113, 8166.101728809826, 8195.426320157532, 8261.339092872557, 8369.3304535637, 8418.242358187792, 4418.734875907456, 4495.57292057254, 4522.34426008227, 4685.976570117127, 4709.552592503706, 3274.6397896231397, 3286.359159963832, 3287.7534184936226, 3290.901272961815, 3308.5202645616732, 559.5299948043663, 575.7322844877068, 588.5821067042363, 592.3365830270039, 596.3470000349611, 624.8125562331282, 675.54103064844, 691.7371398868398, 710.7867639708066, 715.0811207598211, 8960.05919378469, 9045.59294831721, 9066.863997040049, 9083.500407477652, 9130.81738365229, 538.3459097196925, 610.4018062298971, 624.2259598098416, 628.3057221769969, 634.0774173577433, 4148.439960605279, 4225.91548169041, 4377.321515165155, 4403.097365040159, 4520.88697782558, 65179.022314665315, 65261.0, 65648.6717566409, 73512.63243683854, 74941.62529187428, 58634.413655862896, 59499.405005950255, 60171.39828601658, 60341.0, 60445.09332360018, 51249.975000499784, 52383.47616523786, 54077.0, 54498.455015450134, 55292.723536382866, 9000.819983600422, 9087.863682044906, 9136.360454768102, 9185.540722963691, 9254.35219534626, 38507.0, 39185.684776387076, 39336.803315983234, 39355.409668855566, 40369.0, 47318.0, 47746.28380574225, 47949.0, 50395.0, 51438.74280628573, 11589.942050289694, 11693.356865372147, 11699.0, 11938.76122477563, 12053.397330133634, 12211.450484728386, 12547.372631368578, 12711.555095571981, 13037.413316400975, 13278.601641950758, 11937.701557461132, 12229.388530573613, 12260.448279827251, 12265.202761820454, 12334.321612311409, 11741.530338786353, 12144.514219431478, 12345.197562158432, 12441.37793110359, 12635.052371072023, 11814.173007889365, 11993.220440671328, 12150.867277139192, 12156.0, 12334.81497777552, 9869.309148359545, 9910.504474776377, 9962.800743985224, 10080.395176289447, 10359.378437293786, 9399.389039712396, 9718.514074296398, 9747.220222382051, 9796.706098817047, 9816.312858099864], "unit": "score", "name": "yui.html", "value": 6714.254227271184}], "name": "dromaeo_css", "value": 7157.693314802071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 108.0, 111.0, 112.0, 111.0, 101.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 150.0, 170.0, 130.0, 147.0, 150.0, 143.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 160.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 105.0, 91.0, 72.0, 75.0, 72.0, 103.0, 100.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 144.0, 97.0, 93.0, 95.0, 138.0, 94.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 56.0, 58.0, 57.0, 56.0, 66.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.7}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 77.0, 79.0, 78.0, 77.0, 78.0, 77.0, 80.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 108.0, 114.0, 116.0, 112.0, 109.0, 113.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.6}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 141.0, 141.0, 141.0, 143.0, 140.0, 140.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 65.0, 64.0, 62.0, 61.0, 62.0, 62.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.2}], "name": "kraken", "value": 1479.6}]} 20:30:18 INFO - Return code: 0 20:30:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:30:18 ERROR - # TBPL SUCCESS # 20:30:18 INFO - Running post-action listener: _resource_record_post_action 20:30:18 INFO - Running post-run listener: _resource_record_post_run 20:30:19 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 537858048; Read time: 528; Write time: 598608 20:30:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 242798592; Read time: 272; Write time: 341492 20:30:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295059456; Read time: 256; Write time: 257116 20:30:19 INFO - Running post-run listener: _upload_blobber_files 20:30:19 INFO - Blob upload gear active. 20:30:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:30:19 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 20:30:19 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'] 20:30:19 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 20:30:19 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:20 INFO - (blobuploader) - INFO - Done attempting. 20:30:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:21 INFO - (blobuploader) - INFO - Done attempting. 20:30:21 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:21 INFO - Return code: 0 20:30:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:30:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0e19518621f74fcb6b43bae2887a965fd00d5f057d13ff3b7d397304db5f7ad8294ab8c89ae2edf208e250bb810a3e8063c7f3c340cbc3be6c973cc5e44a879", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c998da101a7f62bf731d00c227a4792fb2efd8d3bdb0f0613ad9f776e35f7e4d819959d416347e37469c236ac7f1f00ef1835478895f9ebc893f56944928acbe"} 20:30:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:30:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:30:21 INFO - Contents: 20:30:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0e19518621f74fcb6b43bae2887a965fd00d5f057d13ff3b7d397304db5f7ad8294ab8c89ae2edf208e250bb810a3e8063c7f3c340cbc3be6c973cc5e44a879", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c998da101a7f62bf731d00c227a4792fb2efd8d3bdb0f0613ad9f776e35f7e4d819959d416347e37469c236ac7f1f00ef1835478895f9ebc893f56944928acbe"} 20:30:21 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:21 INFO - Copying logs to upload dir... 20:30:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:30:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.122549 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-23 20:30:20.948787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 20:30:20.952056) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 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/e0e19518621f74fcb6b43bae2887a965fd00d5f057d13ff3b7d397304db5f7ad8294ab8c89ae2edf208e250bb810a3e8063c7f3c340cbc3be6c973cc5e44a879", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c998da101a7f62bf731d00c227a4792fb2efd8d3bdb0f0613ad9f776e35f7e4d819959d416347e37469c236ac7f1f00ef1835478895f9ebc893f56944928acbe"} build_url:https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/HG8QXiynTUO-hanbMN8sLA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0e19518621f74fcb6b43bae2887a965fd00d5f057d13ff3b7d397304db5f7ad8294ab8c89ae2edf208e250bb810a3e8063c7f3c340cbc3be6c973cc5e44a879", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c998da101a7f62bf731d00c227a4792fb2efd8d3bdb0f0613ad9f776e35f7e4d819959d416347e37469c236ac7f1f00ef1835478895f9ebc893f56944928acbe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 20:30:20.976228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:30:20.976536) ========= 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=fa44defc139c4ba8574fe040000001db-1458787978.999630-195086680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 20:30:21.059647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 20:30:21.059968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 20:30:21.060274) ========= ========= Total master_lag: 0.27 =========