builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1455055472.87 results: success (0) buildid: 20160209113008 builduid: 620a8e3417074d10bd8fc989aca24e5a revision: 0e2df20590bdee51dbd978b350f050459d040bb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.867646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.868074) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.868421) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.903054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.903406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.919996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.920298) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.975337) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.975650) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.976051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:32.976379) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 14:04:33-- 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% 19.6M=0.001s 2016-02-09 14:04:33 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.125670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.126072) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020863 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.178540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.179182) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e2df20590bdee51dbd978b350f050459d040bb7 --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 0e2df20590bdee51dbd978b350f050459d040bb7 --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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 14:04:33,359 truncating revision to first 12 chars 2016-02-09 14:04:33,359 Setting DEBUG logging. 2016-02-09 14:04:33,359 attempt 1/10 2016-02-09 14:04:33,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e2df20590bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 14:04:33,621 unpacking tar archive at: fx-team-0e2df20590bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.737153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.737738) ========= echo 0e2df20590bdee51dbd978b350f050459d040bb7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0e2df20590bdee51dbd978b350f050459d040bb7'] 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0e2df20590bdee51dbd978b350f050459d040bb7 program finished with exit code 0 elapsedTime=0.004744 script_repo_revision: '0e2df20590bdee51dbd978b350f050459d040bb7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.793387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.793751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 14:04:33.810371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-09 14:04:33.810737) ========= /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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:34 INFO - MultiFileLogger online at 20160209 14:04:34 in /builds/slave/test-pgo 14:04:34 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 14:04:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:04:34 INFO - {'append_to_log': False, 14:04:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:04:34 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:04:34 INFO - 'branch': 'Fx-Team', 14:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:34 INFO - 'config_files': ('talos/linux_config.py',), 14:04:34 INFO - 'default_actions': ('clobber', 14:04:34 INFO - 'read-buildbot-config', 14:04:34 INFO - 'download-and-extract', 14:04:34 INFO - 'populate-webroot', 14:04:34 INFO - 'create-virtualenv', 14:04:34 INFO - 'install', 14:04:34 INFO - 'run-tests'), 14:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:34 INFO - 'download_minidump_stackwalk': True, 14:04:34 INFO - 'download_symbols': 'ondemand', 14:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:34 INFO - 'installer_path': 'installer.exe', 14:04:34 INFO - 'log_level': 'info', 14:04:34 INFO - 'log_name': 'talos', 14:04:34 INFO - 'log_to_console': True, 14:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:34 INFO - 'opt_config_files': (), 14:04:34 INFO - 'pip_index': False, 14:04:34 INFO - 'sps_profile': False, 14:04:34 INFO - 'sps_profile_interval': 0, 14:04:34 INFO - 'suite': 'dromaeojs', 14:04:34 INFO - 'system_bits': '32', 14:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:34 INFO - 'title': 'talos-linux64-ix-045', 14:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:34 INFO - 'use_talos_json': True, 14:04:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:34 INFO - 'work_dir': 'build'} 14:04:34 INFO - ##### 14:04:34 INFO - ##### Running clobber step. 14:04:34 INFO - ##### 14:04:34 INFO - Running pre-action listener: _resource_record_pre_action 14:04:34 INFO - Running main action method: clobber 14:04:34 INFO - rmtree: /builds/slave/test-pgo/build 14:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:04:34 INFO - Running post-action listener: _resource_record_post_action 14:04:34 INFO - ##### 14:04:34 INFO - ##### Running read-buildbot-config step. 14:04:34 INFO - ##### 14:04:34 INFO - Running pre-action listener: _resource_record_pre_action 14:04:34 INFO - Running main action method: read_buildbot_config 14:04:34 INFO - Using buildbot properties: 14:04:34 INFO - { 14:04:34 INFO - "project": "", 14:04:34 INFO - "product": "firefox", 14:04:34 INFO - "script_repo_revision": "production", 14:04:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:04:34 INFO - "repository": "", 14:04:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:04:34 INFO - "buildid": "20160209113008", 14:04:34 INFO - "pgo_build": "True", 14:04:34 INFO - "basedir": "/builds/slave/test-pgo", 14:04:34 INFO - "buildnumber": 930, 14:04:34 INFO - "slavename": "talos-linux64-ix-045", 14:04:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:04:34 INFO - "platform": "ubuntu64_hw", 14:04:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:04:34 INFO - "branch": "fx-team", 14:04:34 INFO - "repo_path": "integration/fx-team", 14:04:34 INFO - "revision": "0e2df20590bdee51dbd978b350f050459d040bb7", 14:04:34 INFO - "stage_platform": "linux64-pgo", 14:04:34 INFO - "builduid": "620a8e3417074d10bd8fc989aca24e5a", 14:04:34 INFO - "slavebuilddir": "test" 14:04:34 INFO - } 14:04:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:04:34 INFO - Running post-action listener: _resource_record_post_action 14:04:34 INFO - ##### 14:04:34 INFO - ##### Running download-and-extract step. 14:04:34 INFO - ##### 14:04:34 INFO - Running pre-action listener: _resource_record_pre_action 14:04:34 INFO - Running main action method: download_and_extract 14:04:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:04:34 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')]} 14:04:34 INFO - https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/test_packages.json 14:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/test_packages.json 14:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:04:42 INFO - Downloaded 1448 bytes. 14:04:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:04:42 INFO - Using the following test package requirements: 14:04:42 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:04:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'jsshell-linux-x86_64.zip'], 14:04:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:42 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04:42 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')]} 14:04:42 INFO - https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:49 INFO - Downloaded 23289199 bytes. 14:04:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:04:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:04:50 INFO - Return code: 0 14:04:50 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:04: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')]} 14:04:50 INFO - https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:51 INFO - Downloaded 23289199 bytes. 14:04:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:04:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:04:53 INFO - Return code: 0 14:04:53 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')]} 14:04:53 INFO - https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:04:54 INFO - Downloaded 10706547 bytes. 14:04:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:04:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:04:54 INFO - Return code: 0 14:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:54 INFO - https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:04:55 INFO - Downloaded 56545848 bytes. 14:04:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:04:55 INFO - mkdir: /builds/slave/test-pgo/properties 14:04:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:04:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:04:55 INFO - Contents: 14:04:55 INFO - build_url:https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:04:56 INFO - Running post-action listener: _resource_record_post_action 14:04:56 INFO - Running post-action listener: set_extra_try_arguments 14:04:56 INFO - ##### 14:04:56 INFO - ##### Running populate-webroot step. 14:04:56 INFO - ##### 14:04:56 INFO - Running pre-action listener: _resource_record_pre_action 14:04:56 INFO - Running main action method: populate_webroot 14:04:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:56 INFO - '--tppagecycles', 14:04:56 INFO - '7'], 14:04:56 INFO - 'tests': ['tsvgm']}}, 14:04:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:04:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:04:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'tests': ['damp', 'tps']}, 14:04:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['damp', 'tps']}, 14:04:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:56 INFO - 'other': {'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'other_l64': {'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:56 INFO - 'ts_paint', 14:04:56 INFO - 'tpaint', 14:04:56 INFO - 'sessionrestore', 14:04:56 INFO - 'sessionrestore_no_auto_restore']}, 14:04:56 INFO - 'svgr': {'tests': ['tsvgx', 14:04:56 INFO - 'tsvgr_opacity', 14:04:56 INFO - 'tart', 14:04:56 INFO - 'tscrollx', 14:04:56 INFO - 'cart']}, 14:04:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['tsvgx', 14:04:56 INFO - 'tsvgr_opacity', 14:04:56 INFO - 'tart', 14:04:56 INFO - 'tscrollx', 14:04:56 INFO - 'cart']}, 14:04:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'tests': ['tp5o']}, 14:04:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'talos_options': ['--e10s'], 14:04:56 INFO - 'tests': ['tp5o']}, 14:04:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'talos_options': ['--xperf_path', 14:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:56 INFO - 'tests': ['tp5n']}, 14:04:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:56 INFO - 'talos_options': ['--e10s', 14:04:56 INFO - '--xperf_path', 14:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:56 INFO - 'tests': ['tp5n']}}, 14:04:56 INFO - 'talos.zip': {'path': '', 14:04:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:56 INFO - Running post-action listener: _resource_record_post_action 14:04:56 INFO - ##### 14:04:56 INFO - ##### Running create-virtualenv step. 14:04:56 INFO - ##### 14:04:56 INFO - Running pre-action listener: _resource_record_pre_action 14:04:56 INFO - Running main action method: create_virtualenv 14:04:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:04:56 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 14:04:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:04:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:56 INFO - Using real prefix '/usr' 14:04:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:04:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:59 INFO - Installing pip.................done. 14:04:59 INFO - Return code: 0 14:04:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:59 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:04:59 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 14:04:59 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 14:04:59 INFO - Using env: {'DISPLAY': ':0', 14:04:59 INFO - 'HOME': '/home/cltbld', 14:04:59 INFO - 'LANG': 'en_US.UTF-8', 14:04:59 INFO - 'LANGUAGE': 'en_US:en', 14:04:59 INFO - 'LOGNAME': 'cltbld', 14:04:59 INFO - 'MAIL': '/var/mail/cltbld', 14:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:59 INFO - 'MOZ_NO_REMOTE': '1', 14:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:59 INFO - 'NO_EM_RESTART': '1', 14:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:59 INFO - 'SHELL': '/bin/bash', 14:04:59 INFO - 'SHLVL': '1', 14:04:59 INFO - 'TERM': 'linux', 14:04:59 INFO - 'TMOUT': '86400', 14:04:59 INFO - 'USER': 'cltbld', 14:04:59 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:59 INFO - '_': '/tools/buildbot/bin/python'} 14:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:59 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 14:04:59 INFO - Cleaning up... 14:04:59 INFO - Return code: 0 14:04:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:59 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:04:59 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 14:04:59 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 14:04:59 INFO - Using env: {'DISPLAY': ':0', 14:04:59 INFO - 'HOME': '/home/cltbld', 14:04:59 INFO - 'LANG': 'en_US.UTF-8', 14:04:59 INFO - 'LANGUAGE': 'en_US:en', 14:04:59 INFO - 'LOGNAME': 'cltbld', 14:04:59 INFO - 'MAIL': '/var/mail/cltbld', 14:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:59 INFO - 'MOZ_NO_REMOTE': '1', 14:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:59 INFO - 'NO_EM_RESTART': '1', 14:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:59 INFO - 'SHELL': '/bin/bash', 14:04:59 INFO - 'SHLVL': '1', 14:04:59 INFO - 'TERM': 'linux', 14:04:59 INFO - 'TMOUT': '86400', 14:04:59 INFO - 'USER': 'cltbld', 14:04:59 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:59 INFO - '_': '/tools/buildbot/bin/python'} 14:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:59 INFO - Downloading/unpacking psutil>=0.7.1 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:01 INFO - Installing collected packages: psutil 14:05:01 INFO - Running setup.py install for psutil 14:05:01 INFO - building 'psutil._psutil_linux' extension 14:05:01 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 14:05:01 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 14:05:01 INFO - building 'psutil._psutil_posix' extension 14:05:01 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 14:05:01 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 14:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:01 INFO - Successfully installed psutil 14:05:01 INFO - Cleaning up... 14:05:02 INFO - Return code: 0 14:05:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:02 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:02 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 14:05:02 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 14:05:02 INFO - Using env: {'DISPLAY': ':0', 14:05:02 INFO - 'HOME': '/home/cltbld', 14:05:02 INFO - 'LANG': 'en_US.UTF-8', 14:05:02 INFO - 'LANGUAGE': 'en_US:en', 14:05:02 INFO - 'LOGNAME': 'cltbld', 14:05:02 INFO - 'MAIL': '/var/mail/cltbld', 14:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:02 INFO - 'MOZ_NO_REMOTE': '1', 14:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:02 INFO - 'NO_EM_RESTART': '1', 14:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:02 INFO - 'SHELL': '/bin/bash', 14:05:02 INFO - 'SHLVL': '1', 14:05:02 INFO - 'TERM': 'linux', 14:05:02 INFO - 'TMOUT': '86400', 14:05:02 INFO - 'USER': 'cltbld', 14:05:02 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:02 INFO - '_': '/tools/buildbot/bin/python'} 14:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:05:02 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 14:05:02 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 14:05:02 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 14:05:02 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 14:05:02 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 14:05:02 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 14:05:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:05:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:05:04 INFO - Installing collected packages: mozsystemmonitor 14:05:04 INFO - Running setup.py install for mozsystemmonitor 14:05:04 INFO - Successfully installed mozsystemmonitor 14:05:04 INFO - Cleaning up... 14:05:04 INFO - Return code: 0 14:05:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:04 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:04 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 14:05:04 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 14:05:04 INFO - Using env: {'DISPLAY': ':0', 14:05:04 INFO - 'HOME': '/home/cltbld', 14:05:04 INFO - 'LANG': 'en_US.UTF-8', 14:05:04 INFO - 'LANGUAGE': 'en_US:en', 14:05:04 INFO - 'LOGNAME': 'cltbld', 14:05:04 INFO - 'MAIL': '/var/mail/cltbld', 14:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:04 INFO - 'MOZ_NO_REMOTE': '1', 14:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:04 INFO - 'NO_EM_RESTART': '1', 14:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:04 INFO - 'SHELL': '/bin/bash', 14:05:04 INFO - 'SHLVL': '1', 14:05:04 INFO - 'TERM': 'linux', 14:05:04 INFO - 'TMOUT': '86400', 14:05:04 INFO - 'USER': 'cltbld', 14:05:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:04 INFO - '_': '/tools/buildbot/bin/python'} 14:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:05:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 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 14:05:06 INFO - Downloading docopt-0.6.1.tar.gz 14:05:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:06 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:06 INFO - Running setup.py install for blobuploader 14:05:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:05:07 INFO - Running setup.py install for requests 14:05:07 INFO - Running setup.py install for docopt 14:05:07 INFO - Successfully installed blobuploader requests docopt 14:05:07 INFO - Cleaning up... 14:05:07 INFO - Return code: 0 14:05:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05: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')]} 14:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:07 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:07 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 14:05:07 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 14:05:07 INFO - Using env: {'DISPLAY': ':0', 14:05:07 INFO - 'HOME': '/home/cltbld', 14:05:07 INFO - 'LANG': 'en_US.UTF-8', 14:05:07 INFO - 'LANGUAGE': 'en_US:en', 14:05:07 INFO - 'LOGNAME': 'cltbld', 14:05:07 INFO - 'MAIL': '/var/mail/cltbld', 14:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:07 INFO - 'MOZ_NO_REMOTE': '1', 14:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:07 INFO - 'NO_EM_RESTART': '1', 14:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:07 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:07 INFO - 'SHELL': '/bin/bash', 14:05:07 INFO - 'SHLVL': '1', 14:05:07 INFO - 'TERM': 'linux', 14:05:07 INFO - 'TMOUT': '86400', 14:05:07 INFO - 'USER': 'cltbld', 14:05:07 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:07 INFO - '_': '/tools/buildbot/bin/python'} 14:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:07 INFO - Running setup.py (path:/tmp/pip-rVwmn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:07 INFO - Running setup.py (path:/tmp/pip-kR1f8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:07 INFO - Running setup.py (path:/tmp/pip-rqqdxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:08 INFO - Running setup.py (path:/tmp/pip-kh5xzz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:08 INFO - Running setup.py (path:/tmp/pip-ojB1aq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:08 INFO - Running setup.py (path:/tmp/pip-hsQ2Dq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:08 INFO - Running setup.py (path:/tmp/pip-i6MM4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:08 INFO - Running setup.py (path:/tmp/pip-_1uFNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:08 INFO - Running setup.py (path:/tmp/pip-JB8BPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:08 INFO - Running setup.py (path:/tmp/pip-NgQVGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:08 INFO - Running setup.py (path:/tmp/pip-aw9CwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:08 INFO - Running setup.py (path:/tmp/pip-rxAYVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:08 INFO - Running setup.py (path:/tmp/pip-8DZK44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:08 INFO - Running setup.py (path:/tmp/pip-HWUf3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:08 INFO - Running setup.py (path:/tmp/pip-EByGRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:08 INFO - Running setup.py (path:/tmp/pip-ikt0xI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:08 INFO - Running setup.py (path:/tmp/pip-gx_Avs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:09 INFO - Running setup.py install for manifestparser 14:05:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Running setup.py install for mozcrash 14:05:09 INFO - Running setup.py install for mozdebug 14:05:09 INFO - Running setup.py install for mozdevice 14:05:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Running setup.py install for mozfile 14:05:09 INFO - Running setup.py install for mozhttpd 14:05:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Running setup.py install for mozinfo 14:05:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Running setup.py install for mozInstall 14:05:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:05:09 INFO - Running setup.py install for mozleak 14:05:09 INFO - Running setup.py install for mozlog 14:05:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Running setup.py install for moznetwork 14:05:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Running setup.py install for mozprocess 14:05:10 INFO - Running setup.py install for mozprofile 14:05:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Running setup.py install for mozrunner 14:05:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Running setup.py install for mozscreenshot 14:05:10 INFO - Running setup.py install for moztest 14:05:10 INFO - Running setup.py install for mozversion 14:05:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:10 INFO - Cleaning up... 14:05:10 INFO - Return code: 0 14:05:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05: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')]} 14:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:10 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:10 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 14:05:10 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 14:05:10 INFO - Using env: {'DISPLAY': ':0', 14:05:10 INFO - 'HOME': '/home/cltbld', 14:05:10 INFO - 'LANG': 'en_US.UTF-8', 14:05:10 INFO - 'LANGUAGE': 'en_US:en', 14:05:10 INFO - 'LOGNAME': 'cltbld', 14:05:10 INFO - 'MAIL': '/var/mail/cltbld', 14:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:10 INFO - 'MOZ_NO_REMOTE': '1', 14:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:10 INFO - 'NO_EM_RESTART': '1', 14:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:10 INFO - 'SHELL': '/bin/bash', 14:05:10 INFO - 'SHLVL': '1', 14:05:10 INFO - 'TERM': 'linux', 14:05:10 INFO - 'TMOUT': '86400', 14:05:10 INFO - 'USER': 'cltbld', 14:05:10 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:10 INFO - '_': '/tools/buildbot/bin/python'} 14:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:11 INFO - Running setup.py (path:/tmp/pip-GZES7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:11 INFO - Running setup.py (path:/tmp/pip-xniai8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:11 INFO - Running setup.py (path:/tmp/pip-tsXsEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:11 INFO - Running setup.py (path:/tmp/pip-gJvgIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:11 INFO - Running setup.py (path:/tmp/pip-Me6pv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:11 INFO - Running setup.py (path:/tmp/pip-cwxNSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:11 INFO - Running setup.py (path:/tmp/pip-9blcTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:11 INFO - Running setup.py (path:/tmp/pip-NkaTP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:11 INFO - Running setup.py (path:/tmp/pip-DcwRX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:11 INFO - Running setup.py (path:/tmp/pip-o8Ldqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:11 INFO - Running setup.py (path:/tmp/pip-GUECHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:11 INFO - Running setup.py (path:/tmp/pip-hOR9gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:11 INFO - Running setup.py (path:/tmp/pip-bQazWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:11 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)) 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:11 INFO - Running setup.py (path:/tmp/pip-p7LihK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:12 INFO - Running setup.py (path:/tmp/pip-hZcUcS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:12 INFO - Running setup.py (path:/tmp/pip-ub7nH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:12 INFO - Running setup.py (path:/tmp/pip-Q7KJ1Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:12 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)) 14:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:12 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)) 14:05:12 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)) 14:05:12 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)) 14:05:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:14 INFO - Downloading blessings-1.6.tar.gz 14:05:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:14 INFO - Installing collected packages: blessings 14:05:14 INFO - Running setup.py install for blessings 14:05:14 INFO - Successfully installed blessings 14:05:14 INFO - Cleaning up... 14:05:14 INFO - Return code: 0 14:05:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:05:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:14 INFO - Reading from file tmpfile_stdout 14:05:14 INFO - Current package versions: 14:05:14 INFO - argparse == 1.2.1 14:05:14 INFO - blessings == 1.6 14:05:14 INFO - blobuploader == 1.2.4 14:05:14 INFO - docopt == 0.6.1 14:05:14 INFO - manifestparser == 1.1 14:05:14 INFO - mozInstall == 1.12 14:05:14 INFO - mozcrash == 0.16 14:05:14 INFO - mozdebug == 0.1 14:05:14 INFO - mozdevice == 0.48 14:05:14 INFO - mozfile == 1.2 14:05:14 INFO - mozhttpd == 0.7 14:05:14 INFO - mozinfo == 0.9 14:05:14 INFO - mozleak == 0.1 14:05:14 INFO - mozlog == 3.1 14:05:14 INFO - moznetwork == 0.27 14:05:14 INFO - mozprocess == 0.22 14:05:14 INFO - mozprofile == 0.28 14:05:14 INFO - mozrunner == 6.11 14:05:14 INFO - mozscreenshot == 0.1 14:05:14 INFO - mozsystemmonitor == 0.0 14:05:14 INFO - moztest == 0.7 14:05:14 INFO - mozversion == 1.4 14:05:14 INFO - psutil == 3.1.1 14:05:14 INFO - requests == 1.2.3 14:05:14 INFO - wsgiref == 0.1.2 14:05:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:14 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:14 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 14:05:14 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 14:05:14 INFO - Using env: {'DISPLAY': ':0', 14:05:14 INFO - 'HOME': '/home/cltbld', 14:05:14 INFO - 'LANG': 'en_US.UTF-8', 14:05:14 INFO - 'LANGUAGE': 'en_US:en', 14:05:14 INFO - 'LOGNAME': 'cltbld', 14:05:14 INFO - 'MAIL': '/var/mail/cltbld', 14:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:14 INFO - 'MOZ_NO_REMOTE': '1', 14:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:14 INFO - 'NO_EM_RESTART': '1', 14:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:14 INFO - 'SHELL': '/bin/bash', 14:05:14 INFO - 'SHLVL': '1', 14:05:14 INFO - 'TERM': 'linux', 14:05:14 INFO - 'TMOUT': '86400', 14:05:14 INFO - 'USER': 'cltbld', 14:05:14 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:14 INFO - '_': '/tools/buildbot/bin/python'} 14:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 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)) 14:05:14 INFO - Cleaning up... 14:05:14 INFO - Return code: 0 14:05:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:14 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:14 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 14:05:14 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 14:05:14 INFO - Using env: {'DISPLAY': ':0', 14:05:14 INFO - 'HOME': '/home/cltbld', 14:05:14 INFO - 'LANG': 'en_US.UTF-8', 14:05:14 INFO - 'LANGUAGE': 'en_US:en', 14:05:14 INFO - 'LOGNAME': 'cltbld', 14:05:14 INFO - 'MAIL': '/var/mail/cltbld', 14:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:14 INFO - 'MOZ_NO_REMOTE': '1', 14:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:14 INFO - 'NO_EM_RESTART': '1', 14:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:14 INFO - 'SHELL': '/bin/bash', 14:05:14 INFO - 'SHLVL': '1', 14:05:14 INFO - 'TERM': 'linux', 14:05:14 INFO - 'TMOUT': '86400', 14:05:14 INFO - 'USER': 'cltbld', 14:05:14 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:14 INFO - '_': '/tools/buildbot/bin/python'} 14:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:14 INFO - Downloading/unpacking jsonschema 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:16 INFO - Downloading/unpacking functools32 (from jsonschema) 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:16 INFO - warning: no files found matching '*.txt' 14:05:16 INFO - no previously-included directories found matching 'build' 14:05:16 INFO - no previously-included directories found matching 'dist' 14:05:16 INFO - no previously-included directories found matching '.git*' 14:05:17 INFO - Installing collected packages: jsonschema, functools32 14:05:17 INFO - Running setup.py install for functools32 14:05:17 INFO - warning: no files found matching '*.txt' 14:05:17 INFO - no previously-included directories found matching 'build' 14:05:17 INFO - no previously-included directories found matching 'dist' 14:05:17 INFO - no previously-included directories found matching '.git*' 14:05:17 INFO - Successfully installed jsonschema functools32 14:05:17 INFO - Cleaning up... 14:05:17 INFO - Return code: 0 14:05:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:05:17 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')]} 14:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:17 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')]} 14:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:17 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 0x7f9963fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, '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': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', '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 14:05:17 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 14:05:17 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 14:05:17 INFO - Using env: {'DISPLAY': ':0', 14:05:17 INFO - 'HOME': '/home/cltbld', 14:05:17 INFO - 'LANG': 'en_US.UTF-8', 14:05:17 INFO - 'LANGUAGE': 'en_US:en', 14:05:17 INFO - 'LOGNAME': 'cltbld', 14:05:17 INFO - 'MAIL': '/var/mail/cltbld', 14:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:17 INFO - 'MOZ_NO_REMOTE': '1', 14:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:17 INFO - 'NO_EM_RESTART': '1', 14:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:17 INFO - 'SHELL': '/bin/bash', 14:05:17 INFO - 'SHLVL': '1', 14:05:17 INFO - 'TERM': 'linux', 14:05:17 INFO - 'TMOUT': '86400', 14:05:17 INFO - 'USER': 'cltbld', 14:05:17 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:17 INFO - '_': '/tools/buildbot/bin/python'} 14:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:17 INFO - Downloading/unpacking flake8 14:05:17 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 14:05:17 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 14:05:17 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 14:05:17 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 14:05:17 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 14:05:17 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 14:05:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:05:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:05:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 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 14:05:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:05:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:19 INFO - no previously-included directories found matching 'docs/_build' 14:05:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:05:19 INFO - Running setup.py install for pep8 14:05:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:20 INFO - no previously-included directories found matching 'docs/_build' 14:05:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:05:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:05:20 INFO - Cleaning up... 14:05:20 INFO - Return code: 0 14:05:20 INFO - Running post-action listener: _resource_record_post_action 14:05:20 INFO - Running post-action listener: _start_resource_monitoring 14:05:20 INFO - Starting resource monitoring. 14:05:20 INFO - ##### 14:05:20 INFO - ##### Running install step. 14:05:20 INFO - ##### 14:05:20 INFO - Running pre-action listener: _resource_record_pre_action 14:05:20 INFO - Running main action method: install 14:05:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:20 INFO - Reading from file tmpfile_stdout 14:05:20 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:05:20 INFO - Reading from file tmpfile_stdout 14:05:20 INFO - Output received: 14:05:20 INFO - Usage: mozinstall [options] installer 14:05:20 INFO - Options: 14:05:20 INFO - -h, --help show this help message and exit 14:05:20 INFO - -d DEST, --destination=DEST 14:05:20 INFO - Directory to install application into. [default: 14:05:20 INFO - "/builds/slave/test-pgo"] 14:05:20 INFO - --app=APP Application being installed. [default: firefox] 14:05:20 INFO - mkdir: /builds/slave/test-pgo/build/application 14:05:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:05:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:05:36 INFO - Reading from file tmpfile_stdout 14:05:36 INFO - Output received: 14:05:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:05:36 INFO - Running post-action listener: _resource_record_post_action 14:05:36 INFO - ##### 14:05:36 INFO - ##### Running run-tests step. 14:05:36 INFO - ##### 14:05:36 INFO - Running pre-action listener: _resource_record_pre_action 14:05:36 INFO - Running main action method: run_tests 14:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:05:36 INFO - Python 2.7.3 14:05:36 INFO - Return code: 0 14:05:36 INFO - grabbing minidump binary from tooltool 14:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:36 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 0x23938c0>, '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 0x23947c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2394c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:05:36 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 14:05:36 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 14:05:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:36 INFO - Return code: 0 14:05:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:05:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:05:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:05:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:05:37 INFO - Return code: 0 14:05:37 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/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:05:37 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/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 14:05:37 INFO - Using env: {'DISPLAY': ':0', 14:05:37 INFO - 'HOME': '/home/cltbld', 14:05:37 INFO - 'LANG': 'en_US.UTF-8', 14:05:37 INFO - 'LANGUAGE': 'en_US:en', 14:05:37 INFO - 'LOGNAME': 'cltbld', 14:05:37 INFO - 'MAIL': '/var/mail/cltbld', 14:05:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:37 INFO - 'MOZ_NO_REMOTE': '1', 14:05:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:37 INFO - 'NO_EM_RESTART': '1', 14:05:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:05:37 INFO - 'SHELL': '/bin/bash', 14:05:37 INFO - 'SHLVL': '1', 14:05:37 INFO - 'TERM': 'linux', 14:05:37 INFO - 'TMOUT': '86400', 14:05:37 INFO - 'USER': 'cltbld', 14:05:37 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440', 14:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:37 INFO - '_': '/tools/buildbot/bin/python'} 14:05:37 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/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:05:38 INFO - mozversion application_buildid: 20160209113008 14:05:38 INFO - mozversion application_changeset: 0e2df20590bdee51dbd978b350f050459d040bb7 14:05:38 INFO - mozversion application_display_name: Nightly 14:05:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:38 INFO - mozversion application_name: Firefox 14:05:38 INFO - mozversion application_remotingname: firefox 14:05:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:05:38 INFO - mozversion application_vendor: Mozilla 14:05:38 INFO - mozversion application_version: 47.0a1 14:05:38 INFO - mozversion platform_buildid: 20160209113008 14:05:38 INFO - mozversion platform_changeset: 0e2df20590bdee51dbd978b350f050459d040bb7 14:05:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:05:38 INFO - mozversion platform_version: 47.0a1 14:05:38 INFO - using testdate: 1455055538 14:05:38 INFO - actual date: 1455055538 14:05:38 INFO - starting webserver on 'localhost:56656' 14:05:38 INFO - SUITE-START | Running 2 tests 14:05:38 INFO - TEST-START | dromaeo_css 14:05:38 INFO - operating with platform_type : linux_ 14:05:38 INFO - Initialising browser for dromaeo_css test... 14:05:38 INFO - TEST-INFO | started process 18095 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJF0TTQ/profile http://localhost:56656/getInfo.html) 14:05:41 INFO - PROCESS | 18095 | __metrics Screen width/height:1600/1200 14:05:41 INFO - PROCESS | 18095 | colorDepth:24 14:05:41 INFO - PROCESS | 18095 | Browser inner width/height: 1024/697 14:05:41 INFO - PROCESS | 18095 | __metrics 14:05:42 INFO - PROCESS | 18095 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:43 INFO - TEST-INFO | 18095: exit 0 14:05:43 INFO - Browser initialized. 14:05:43 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:43 INFO - TEST-INFO | started process 18187 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJF0TTQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:54 INFO - PROCESS | 18187 | RSS: Main: 152473600 14:05:54 INFO - PROCESS | 18187 | 14:06:45 INFO - PROCESS | 18187 | 1455055605671 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] 14:08:54 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56656/tests/dromaeo/cssquery-ext.html) 14:08:55 INFO - PROCESS | 18187 | RSS: Main: 236138496 14:08:55 INFO - PROCESS | 18187 | 14:11:58 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-ext.html (next: http://localhost:56656/tests/dromaeo/cssquery-jquery.html) 14:11:58 INFO - PROCESS | 18187 | RSS: Main: 233897984 14:11:58 INFO - PROCESS | 18187 | 14:15:00 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56656/tests/dromaeo/cssquery-mootools.html) 14:15:01 INFO - PROCESS | 18187 | RSS: Main: 239415296 14:15:01 INFO - PROCESS | 18187 | 14:18:03 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56656/tests/dromaeo/cssquery-prototype.html) 14:18:04 INFO - PROCESS | 18187 | RSS: Main: 219000832 14:18:04 INFO - PROCESS | 18187 | 14:21:06 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56656/tests/dromaeo/cssquery-yui.html) 14:21:07 INFO - PROCESS | 18187 | RSS: Main: 220602368 14:21:07 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | Cycle 1(1): loaded http://localhost:56656/tests/dromaeo/cssquery-yui.html (next: http://localhost:56656/tests/dromaeo/cssquery-dojo.html) 14:24:09 INFO - PROCESS | 18187 | RSS: Main: 262524928 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | __start_tp_report 14:24:09 INFO - PROCESS | 18187 | _x_x_mozilla_page_load 14:24:09 INFO - PROCESS | 18187 | _x_x_mozilla_page_load_details 14:24:09 INFO - PROCESS | 18187 | |i|pagename|runs| 14:24:09 INFO - PROCESS | 18187 | |0;dojo.html;3134.5611614373993;3156.7948083374595;3211.0366889933016;3216.7909085909428;3237.514372844073;5204.245384419257;5239.161734122541;5260.605454590906;5311.893762124755;5365.195220716894;5225.111731005729;5251.054810134175;5303.310569625944;5345.412004679482;5363.034653762321;4829.541193586612;4848.6848354857;4857.198562237227;4900.901981960359;4964.329815474919;4869.293952376921;4926.8392255263725;5006.749662516878;5039.118154322997;5056.519630635084;4796.5683088521855;4861.0277944411255;4914.827981020683;4916.459189489154;4984;4783.7129772213775;4825.541573550507;4836.830710925136;4851.393575803025;4871.464138944749;4860.586850117745;4863.17326054568;4868.805247790084;4869.050535145648;4871.926921096187;5042.773075211624;5124.92312615311;5131.384233891919;5143;5194.948050519484;5668.376478587352;5683.9715801420725;5684.573656975744;5689.800856970028;5692.971535142339;5698.800541981052;5716.514096301819;5718;5722.456366645204;5724.627899186539;5275.261463395128;5322;5356.758945847408;5400;5472.972635136799;5840.824775256664;5848.941510584839;5859.707014649251;5883.764649413975;5903.58674892762;5640.407757185437;5642.915356269659;5644.6330988485615;5644.97177514118;5649.548036157097;5647.632903861236;5677.318721753416;5718.885622287531;5743;5797.565182611321;5684.232628595169;5688.40271771458;5689.9146512802345;5694.316681998187;5700.743466544015;5403.83788486346;5641.153826925994;5695.7152142392715;5699.059655156852;5705.971470142623;4385;4387.802548885244;4414.646828253732;4417.602415782595;4455.443069616298;3958.4853968984426;3961.1483531040963;3978.701597380208;3983.4024896265214;4005.8998525036523;5226.5818734501145;5295.338082739658;5317.574594032468;5326.255606387906;5332.493413125747;5703.973284808774;5708.315002199763;5726.656400615976;5728.312602487645;5760.6543607382855;5219.739013049332;5289.523942845162;5290.444503327172;5290.841274761763;5295.7087360195555;4710.552497512731;4757.119932812441;4793.760311984387;4799.088173247072;4843.104025755247;5913.438223368859;5921.496672782861;5923.407659234128;5924.7333869975955;5928.170056192136;5664.830055098354;5664.85837854057;5666.15007748841;5667.603267771216;5688.687122208318;5788.044972579477;5872.55955803325;5876.500497457593;5898.911516327173;5986.970065149646;5581.6371935824045;5582.5533957282505;5583.022970979981;5583.581231407742;5589.049861523632;5630.127330263652;5645.802396916089;5662.943370566241;5675.120356344773;5707.68607726579;5488.643238189505;5583.944160558505;5585.5531557476115;5637.915431268452;5679.0345641240265;5602.635828671123;5605.467480589337;5606.495415412633;5606.551475882001;5608.10270356741;5422.891542169055;5529.695866727368;5535.169724541351;5540.944590554042;5542.2795036644975;5546.278983732089;5564.4713752193475;5620.297462817148;5624.493795558419;5669.461401166883;5490.176473529003;5490.91763623538;5499.175123731472;5506.476884696108;5516.089845175501 14:24:09 INFO - PROCESS | 18187 | |1;ext.html;519.0320053100968;530.4562823106313;548.4926443040187;549.0693274899045;567.4297331182163;35920;36854.447183292235;37015.44476832843;37016.81491592538;37065;40023.399649005216;40669;40683.186336273255;40704.185916281654;40886.182276354455;8339.791505212357;8479.406441549094;8553.871691924625;8557.786055348635;8560.657573697044;8509;8714.172153645426;8728.258098061673;8735.126487351277;8736.21374076333;8610.397272190949;8787.824243515126;8799.912000879973;8805.119488051176;8815.074417186168;8668.089850565695;8705.695300664509;8751.474911505331;8759.912400876005;8761.08008659088;8582.399232053758;8697.478151310941;8732.51971141587;8735.43219690718;8742.169493898069;40645.79677101596;40854.59145408538;40863;40892.18215635671;40894.591054089375;3168.714815666578;3559;3622.275544891006;3811.9809400952818;3991;29800.254993625116;30010.24974375636;30064.248393790112;30244;31010.534841977387;4029.4157347184787;4036.777977211252;4065.79671016448;4084.5915408459214;4168.854090106862;264795;268072;268417;268862;269102;51827.74086129621;52567.21149182766;57848;58141;60358;53986.46013539814;54063;54179.45820541823;54310.728446358306;54338.728306358214;14637.121772693672;14798.408063677332;14956.92521537407;14965.401383944738;14970;10025.14786243163;11099.500522476508;11365.09079273656;11788.882111178778;11907.464164112636;19860.10629521675;20328;20502.58994820095;20514.487137821674;20555.177792888415;7325.377342925804;7469.58917259556;7518.924810751932;7528.096628404626;7528.661210245552;1003.8895721470633;1005.5374527717332;1018.6485662446444;1051.8895515970867;1136.3522792008641;29222.269443263664;29593.55609665857;29609.555856662166;30087;30142.397152056838;1070.175964507325;1079.6005477973042;1154.7517283784027;1228.5515786737956;1236.975260494785;15614;15627.398454095764;15664.843351566338;15778.76331855023;16006.439774608065;317061;319536.21855125536;319983;320524;321405;43703.78148109239;49650.75174624104;52886.73556632192;53077.7346113267;53413.73293133509;1310.960671179866;1316.6642506160867;1327.973440531184;1354.1604205392719;1356.125299182022;28011.159665210078;29093;29378.11865644034;29855.552166717083;30212.5468117974;41462.79268603758;44634.10731785411;47087.529124708315;48371.5162848367;48436.51563484461;193217;196802;197138;197615;197697;27554.448911022067;27780.722192778623;27873.44253114967;27901.58147627828;27912.720872791826;36930;38192.42711359276;38288.80855595704;40092.3986140214;41986.79006604947;34367.82816085903;34863.47704784481;35318.82340588281;35897.64102359048;35918;35046.47430288497;35412.82293588515;35721.642783571835;35978.46032309465;36302.636973629924;33694;34424.31151377009;34493.655063450045;34674.47988280228;34738.305233895684;30071;32063.198420039687;32352.514712279804;32633.18417039593;32769.50845737364;25272.87363563244;25643.743562564134;25867.482650346512;25996.480070398866;26146.215613531625 14:24:09 INFO - PROCESS | 18187 | |2;jquery.html;359.3029522725913;365.37703216016695;368.88748931575867;369.12517333918606;374.9906252343693;13292.335383230848;13851.30743462828;16427.4250401236;17021.57446063849;17915.104244787773;15166.469173578927;15647.374105035813;15674.294656740445;15903;17060.82939170608;5322.92015619767;5450.509454149126;5488.451154884519;5489.560835133199;5490.670559766407;3991.0621004064024;5415.404305526389;5662.150677398382;5901.5278777697895;5925.466707996279;5742.569307301948;5798.159266906296;5852.531797456215;5892.587518873681;5912.467877890989;5865.501432378253;5879.882402351972;5880.147378630075;5885.85285367865;5888.087346461284;5086.084504789136;5110.565601923841;5129.794808207667;5134.768935397916;5186.1442861927735;19709.11308991099;20045.79954200454;20193.19227230909;20216.898915505328;20317.18731250748;2216.7007453993665;2218.4810328339254;2277.1802151225547;2334.0197117210814;2356.2106694257445;12018;12770.042246831432;12804.871951280555;12826.166299190523;13260.336983150804;1845.713914343279;1899;1916.051554480541;1931.652302585534;1941.7864034956144;53731.73134134343;60231.69884150595;60355.698221509054;62031.379686203014;62532.06201906975;9794.902050979399;9932.404055756677;9989.900100999042;10025.699229023141;10082.59669613222;13218.60344189676;13267.076273940225;13295;13296.534621288209;13298.135621184592;7205.495615306878;7312.817179570447;7333.669984850588;7335.376492998155;7367.373773229228;7057.647117644097;7068.434525237969;7199.532030418006;7273.490855640054;7275.854482910418;4125.958740412558;4318.093200427946;4461.620762235181;4466.531014243523;4539.614132798749;1837.9724304135448;1840.1144960130873;1840.9355672551396;1844.5112045308003;1851.7685289338833;942.1002942190192;957.4159762544842;976.4483067067084;990.0396615283164;1055.2718624149466;12820.93589532065;15202.087874727551;15701.450449234222;16717.83282167187;16780.496585102468;894.1550235027836;1000.4247557654378;1016.5425558498705;1053.8893416191343;1097.3909480238385;9162.954185229031;9306.395084319498;9321.953390233006;9493.240540756722;9494.382865113745;379976;437205;460410;502858;538302;75579.62210189024;76235;76620.61689691516;76990;77500;1192.6243233381458;1199.7120691034263;1215.1493954231896;1233.0936761480305;1252.2423933520272;15199.316030778862;15584.142872142142;15611.297491612677;15874.126923019345;15976.840231598;32450.18874528061;33628;34186;34420.82789586136;34878.82560587181;48493.272600910306;48641;48696.5130348692;48809.2678609814;49476.50523494719;7321.048263725682;7438.623854586919;7588.392928565591;7605.467617266738;7649.349805266392;7516.624168791648;9229.584668689791;9799.314048016571;10353.689389318333;10726;9454.810903782023;9811.362261452983;9977.800443990935;10086.344387614781;10110.09009189147;9481.478518681539;9754.512274386394;9821.950890245504;10022.599096036078;10036.197104231498;8351.498910065415;9436.245100392089;9668.178204852666;9862.161716254199;9945.126209717477;7201;7201.3518783309755;7218.061651985208;7392;7461.104667439942;7335.372311468563;7893;9715.514224288898;9963.50182490858;10308.536115874653 14:24:09 INFO - PROCESS | 18187 | |3;mootools.html;1337.197681391166;1507.6080219143023;1526.9694606107876;1716.7596536484887;1863.329201487465;6977.720891164354;7639.541627502354;7760.456768026241;7766.766996990085;7783.844323113534;7473.701051957915;7647.847043059135;7648.885266721004;7650.120236172842;7650.4262180336555;1994.9900250498727;2259.638457846745;2312.745597984229;2322.837401381904;2347.612643913752;2342.2153578551206;2347.9882600586975;2356.5051339218785;2357.068957761683;2357.6227803551437;2248.9887550562225;2324.1865347128537;2329.1964272326104;2331.067572970817;2331.4171457135717;2296.1848543766973;2312.387217387394;2362.161432691387;2366.621340585515;2366.6568347589673;2337.322176568793;2349.612313968193;2352.023910077316;2365.3022358404314;2367.5856725073045;7880;7913.683452661944;7914.920850791476;7918.168592297841;7926.167752386032;4814.927776083362;4937.777799998973;4942.604591632697;4973.303737476756;4980.800767969313;3263.298390845956;3269.623993240784;3335.8999230023137;3365.2428203654226;3402.4045791986305;1049.6273822792875;1051.4952822645173;1056.6618682021756;1068.1401471815186;1076.8869268726748;10820;10904.073153781937;10983.835242471368;11009.669709908796;11011.119110471143;4532.750698711537;4538.069695712371;4589.2198326284615;4606.930896036562;4612.377329060601;9384.624615015324;9385.38994965325;9395.248380129573;9396.154346108882;9398.48308343034;4897.436794768576;4930.556249937523;4932.210846264652;4942.703437793743;4943.975280123648;4445.26653102241;4445.488768791631;4447.888027993002;4449.1101779644205;4451.1765323415275;3392.3215356928713;3437.1750779813165;3439.5872495300723;3719.330520506335;3784.110733977513;1234.3149551998727;1247.5134697467995;1248.818921256431;1257.0006844558598;1258.031315886762;1346.0712108645005;1347.7439286535528;1378.1042322490262;1389.534505940501;1391.436468230348;7091.3972312353;7200.855982880313;7207;7207.063081799437;7222.566646001257;1120.9495572699248;1132.5073592986912;1134.7900638381925;1137.4085475552665;1137.9943100284445;5849.181114643953;5971.462568368867;5983.341832398432;5996.4603185713495;5998.340182579913;8937.195652391316;9302.720918372459;9361.063893610584;9435.716928492157;9511.429314241168;9199.080091990747;9392.577334019848;9401.717948461557;9403.059694030542;9405.670801521914;7210.639468026578;7214.783556493314;7306.050213472215;7341.229170937081;7392.778216653509;6931.514793964576;6945.895811562932;6974.128233970754;6984.476164287597;6987.790366289019;7969.521828690297;8065.112837587743;8292.502449853027;8307.127751585997;8428.831423371621;8443.155684431753;8589;8601.784955375915;8601.913980860361;8610;6593.3736295051895;6772.627505487246;6774.153230846145;6776.28848970851;6793.252742198255;6599.274079851117;7028.121484814398;7259.637018148966;7275.454340924346;7332.156801967629;6856.314368563104;6930.653467326714;6941.409980151541;7016.614086225102;7065.328793764585;6814.8637027260165;6823.863522729617;6824.18109826824;6887.173539175331;6969.512134150561;6921.688524016331;6936.4797640176175;6949;6949.131358580177;6952.826179345557;6283.717232724447;6407.135036769976;6428.4214420702365;6505.447037001908;6506.512011599244;6494.610323380423;6535.836604084936;6539.411452969255;6540.542162048611;6544 14:24:09 INFO - PROCESS | 18187 | |4;prototype.html;346.7659329952282;350.6160753974399;350.8842082112903;352.23213394799325;356.4759803089459;5889.234399528055;5893;5896.204012458322;5899.144624029514;5906.497947674442;5549.944500555003;5596.356419011815;5635.943640563593;5805.3323867755225;5849.2980842298875;4572.657050721193;4572.885677858047;4578.061497393043;4582.793774280157;4589.357489951392;4373.365861950016;4575.496695363524;4577.130345234412;4591.127685739715;4593.5406459354135;4401.449818772653;4520.434945631796;4536.9092618147615;4552.795124219418;4556.817727290904;4517.4579050513985;4528.818847246106;4529.365888775574;4536.024754677744;4538.568835960578;3998.7400818946967;4026.315526360526;4028.194361127757;4031.475908131924;4035.0921042765435;5448.237246785453;5527.751251193706;5545.72271386429;5560.36055853578;5561.026820306471;5239.685618862881;5264.815101732776;5273.34083239595;5278.155495120763;5285.524302812727;6172.567920245585;6187.350328215518;6188.47397971173;6190.783322583688;6197.783077592308;4414.359917811931;4436.201483732927;4441.400410944513;4450.198964186445;4450.465944086698;6269.2476902771505;6430.196225471816;6439.613623182624;6440.774572889926;6443.613383196976;4549.499555048942;4550.226461501553;4554.612857907049;4556.84051058218;4562.885927851764;4592.127495775792;4600.7469589172915;4607.746573938399;4609.3086037094035;4616.907661846744;5247.291615631917;5251.973740131351;5257.921131183035;5260.842174734764;5271.156614941591;6050.092486127028;6218.875622487525;6222.222222222223;6224.719887604978;6229;1611.5971007248188;1627.2758622413148;1629.5600187949424;1630.8287629798938;1633.1099550744873;1117.5697356517637;1128.5542210826677;1133.2633788037842;1150.5685367987005;1150.9712257193637;5779.422057794187;5779.450952159538;5781.219535362757;5794.449527294901;5797.449242321973;6356.078368636522;6389.7539979703515;6392.616443013434;6400.039994000937;6404.039394090923;5692.886142277214;5787.71061446926;5789.768409263583;5802.65184088956;5942.10868369748;3426.7087297579487;3441.8795342162903;3467.6705712957228;3482.7039701625645;3489.3021395720957;6717.462602991749;6722;6733.8653226935185;6739.292374300726;6746.089277947414;6436.742530298736;6606.537542371988;6620.735170593122;6642.368974947372;6644.468442524683;6753.425958793459;6761.526693131434;6764.526483146231;6764.5603035802515;6765.323467653196;6476.902846457213;6484.967575162094;6485.77299794505;6488.675566221765;6492.091107244895;6252.5935814171935;6351.745930162741;6365.61806291624;6367.331430199948;6374.3306952771145;6739.494537909578;6745.898811517929;6747.291534388818;6752.054712340178;6757.493188011017;4463;4467.955320446754;4500.594946454704;4500.662450316174;4509.458864936098;6303.338149494237;6477.676116194266;6478.222613286436;6479.287278399278;6494.188226471691;6302.401271879347;6307.274663413767;6308.558400912076;6314.273858506331;6316.684165791784;6232.781852635136;6252;6281.874362512815;6293.37066293367;6293.874122517615;6080.391960803884;6178.165947597017;6187.628742275478;6188.44304012641;6203.627782333075;6314.147590075465;6314.652694101868;6318.842028949313;6326.114343991937;6327.620342779448;6120.510359171167;6155.230596175478;6162.599431036968;6163.044728067157;6164.7670465907895 14:24:09 INFO - PROCESS | 18187 | |5;yui.html;696.4880812602739;760.8136006678363;775.8603451378754;782.4014628808962;819.4960099538778;13794.793078103836;14035.36840842162;14046.578602641912;14048.43806247749;14058.64853378666;13166.144200626952;13441.32793360333;13540.526081587146;13566.457341706344;13573.457061717545;669.638395266558;680.5270337115682;797.7965618767221;814.9877751833727;815.2744057788543;792.1088775127981;814.3322475570035;817.697451942782;819.2381085590398;819.9508029518248;842.2588122452233;843.9071702112763;844.1516276142469;844.543946269014;845.0028965820329;692.3561088187984;821.8849361089423;836.8033512124646;839.7186942374251;840.8276303357796;611.8653896142841;617.9567430279837;618.1376979114156;619.0590302739855;621.0870021069021;13675.31623418825;13720.725585488333;13724.794128088086;13755.656108597264;13760.793588096187;13187.73624527504;13214;13398.464061437531;13454.730905381935;13610.455581776718;10041.899581004243;10157.898421015769;10198.643047493302;10218.642347517876;10338.172946164364;3604.819759012039;3619.8733044343585;3629.4192929131214;3630.3465376232266;3738.6635202831603;45747.54252457466;45941;45947.77026114848;46043.53956460426;46071.76964115158;10678.73303167427;10701.518431670593;10757.677269681923;10884.564617415215;10895.564177432814;19000.429987100408;19007.42977710671;19036.143373548224;19065.714014289795;19083.332083377016;7444.702211911463;7576.772696819105;7632.885506717404;7729.652165652559;8068.273855353046;4362.781860906942;4370.7159034662645;4393.121375724868;4434.312681534368;4517.34498497716;3101.9069427917198;3122.7970181938103;3127.9530807037913;3128.6402063762503;3144.3868445653334;560.9523190528769;561.9213310136585;563.5491606714612;597.5787070115558;624.7969409941787;620.9815901920854;681.2234053179379;713.0836874616093;719.6365835253164;724.199759266014;9172.816543669223;9330.58012389444;9361.297902657328;9508;9554.952225238829;567.890797881595;674.069783698493;702.2731472925498;702.6556987076295;712.6757325416922;4106.322456794655;4129.561507867326;4133.979330103391;4155.97922010388;4244.490661120685;51951.740241298554;52869;53173.46826531685;53378;54184.45815541873;47821.28268075982;48213.75893120512;48613.270800938015;48823.511764882605;48905;43096;43189.78405108017;43251.56748432538;43829.12341753211;44613;8240.299574536231;8392.622331995197;8414;8597.785055373666;8610.569471526273;32953.34093318168;32966.83516582402;33609.327813444084;33847.153821154665;34015.65984340125;39803.20393592054;40278;42885;44161.77919110384;47064.7646761764;11252.774944501229;11378.43107844621;11409;11616.593419230287;11869.881301186877;11803.527858885549;12162.878371216175;12389.876101238871;12929;13036.217826930415;11414.543418263176;11487.540498380306;11703;11893.881061189624;12231.510739570673;10940.671779846618;11366.090712743126;12022.643543894497;12075;12100.971417429266;11350.205485615928;11547.364894930859;11771.646850594496;11936.10479214045;12232.75534489323;9763.463009534544;9884;10227.693169204937;10332.17342612574;10577.894221057999;9627.304592351999;9659.32384733062;10311.948440257751;10357.896421035693;10363.533640986325 14:24:09 INFO - PROCESS | 18187 | __end_tp_report 14:24:09 INFO - PROCESS | 18187 | __start_cc_report 14:24:09 INFO - PROCESS | 18187 | _x_x_mozilla_cycle_collect,814 14:24:09 INFO - PROCESS | 18187 | __end_cc_report 14:24:09 INFO - PROCESS | 18187 | __startTimestamp1455056649927__endTimestamp 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | ------- Summary: start ------- 14:24:09 INFO - PROCESS | 18187 | Number of tests: 6 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#0] dojo.html Cycles:165 Average:5293.37 Median:5516.09 stddev:579.49 (10.5%) stddev-sans-first:555.97 14:24:09 INFO - PROCESS | 18187 | Values: 3134.6 3156.8 3211.0 3216.8 3237.5 5204.2 5239.2 5260.6 5311.9 5365.2 5225.1 5251.1 5303.3 5345.4 5363.0 4829.5 4848.7 4857.2 4900.9 4964.3 4869.3 4926.8 5006.7 5039.1 5056.5 4796.6 4861.0 4914.8 4916.5 4984.0 4783.7 4825.5 4836.8 4851.4 4871.5 4860.6 4863.2 4868.8 4869.1 4871.9 5042.8 5124.9 5131.4 5143.0 5194.9 5668.4 5684.0 5684.6 5689.8 5693.0 5698.8 5716.5 5718.0 5722.5 5724.6 5275.3 5322.0 5356.8 5400.0 5473.0 5840.8 5848.9 5859.7 5883.8 5903.6 5640.4 5642.9 5644.6 5645.0 5649.5 5647.6 5677.3 5718.9 5743.0 5797.6 5684.2 5688.4 5689.9 5694.3 5700.7 5403.8 5641.2 5695.7 5699.1 5706.0 4385.0 4387.8 4414.6 4417.6 4455.4 3958.5 3961.1 3978.7 3983.4 4005.9 5226.6 5295.3 5317.6 5326.3 5332.5 5704.0 5708.3 5726.7 5728.3 5760.7 5219.7 5289.5 5290.4 5290.8 5295.7 4710.6 4757.1 4793.8 4799.1 4843.1 5913.4 5921.5 5923.4 5924.7 5928.2 5664.8 5664.9 5666.2 5667.6 5688.7 5788.0 5872.6 5876.5 5898.9 5987.0 5581.6 5582.6 5583.0 5583.6 5589.0 5630.1 5645.8 5662.9 5675.1 5707.7 5488.6 5583.9 5585.6 5637.9 5679.0 5602.6 5605.5 5606.5 5606.6 5608.1 5422.9 5529.7 5535.2 5540.9 5542.3 5546.3 5564.5 5620.3 5624.5 5669.5 5490.2 5490.9 5499.2 5506.5 5516.1 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#1] ext.html Cycles:180 Average:43145.48 Median:19485.91 stddev:69483.78 (356.6%) stddev-sans-first:69604.98 14:24:09 INFO - PROCESS | 18187 | Values: 519.0 530.5 548.5 549.1 567.4 35920.0 36854.4 37015.4 37016.8 37065.0 40023.4 40669.0 40683.2 40704.2 40886.2 8339.8 8479.4 8553.9 8557.8 8560.7 8509.0 8714.2 8728.3 8735.1 8736.2 8610.4 8787.8 8799.9 8805.1 8815.1 8668.1 8705.7 8751.5 8759.9 8761.1 8582.4 8697.5 8732.5 8735.4 8742.2 40645.8 40854.6 40863.0 40892.2 40894.6 3168.7 3559.0 3622.3 3812.0 3991.0 29800.3 30010.2 30064.2 30244.0 31010.5 4029.4 4036.8 4065.8 4084.6 4168.9 264795.0 268072.0 268417.0 268862.0 269102.0 51827.7 52567.2 57848.0 58141.0 60358.0 53986.5 54063.0 54179.5 54310.7 54338.7 14637.1 14798.4 14956.9 14965.4 14970.0 10025.1 11099.5 11365.1 11788.9 11907.5 19860.1 20328.0 20502.6 20514.5 20555.2 7325.4 7469.6 7518.9 7528.1 7528.7 1003.9 1005.5 1018.6 1051.9 1136.4 29222.3 29593.6 29609.6 30087.0 30142.4 1070.2 1079.6 1154.8 1228.6 1237.0 15614.0 15627.4 15664.8 15778.8 16006.4 317061.0 319536.2 319983.0 320524.0 321405.0 43703.8 49650.8 52886.7 53077.7 53413.7 1311.0 1316.7 1328.0 1354.2 1356.1 28011.2 29093.0 29378.1 29855.6 30212.5 41462.8 44634.1 47087.5 48371.5 48436.5 193217.0 196802.0 197138.0 197615.0 197697.0 27554.4 27780.7 27873.4 27901.6 27912.7 36930.0 38192.4 38288.8 40092.4 41986.8 34367.8 34863.5 35318.8 35897.6 35918.0 35046.5 35412.8 35721.6 35978.5 36302.6 33694.0 34424.3 34493.7 34674.5 34738.3 30071.0 32063.2 32352.5 32633.2 32769.5 25272.9 25643.7 25867.5 25996.5 26146.2 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#2] jquery.html Cycles:180 Average:25824.10 Median:48752.89 stddev:76550.10 (157.0%) stddev-sans-first:76740.96 14:24:09 INFO - PROCESS | 18187 | Values: 359.3 365.4 368.9 369.1 375.0 13292.3 13851.3 16427.4 17021.6 17915.1 15166.5 15647.4 15674.3 15903.0 17060.8 5322.9 5450.5 5488.5 5489.6 5490.7 3991.1 5415.4 5662.2 5901.5 5925.5 5742.6 5798.2 5852.5 5892.6 5912.5 5865.5 5879.9 5880.1 5885.9 5888.1 5086.1 5110.6 5129.8 5134.8 5186.1 19709.1 20045.8 20193.2 20216.9 20317.2 2216.7 2218.5 2277.2 2334.0 2356.2 12018.0 12770.0 12804.9 12826.2 13260.3 1845.7 1899.0 1916.1 1931.7 1941.8 53731.7 60231.7 60355.7 62031.4 62532.1 9794.9 9932.4 9989.9 10025.7 10082.6 13218.6 13267.1 13295.0 13296.5 13298.1 7205.5 7312.8 7333.7 7335.4 7367.4 7057.6 7068.4 7199.5 7273.5 7275.9 4126.0 4318.1 4461.6 4466.5 4539.6 1838.0 1840.1 1840.9 1844.5 1851.8 942.1 957.4 976.4 990.0 1055.3 12820.9 15202.1 15701.5 16717.8 16780.5 894.2 1000.4 1016.5 1053.9 1097.4 9163.0 9306.4 9322.0 9493.2 9494.4 379976.0 437205.0 460410.0 502858.0 538302.0 75579.6 76235.0 76620.6 76990.0 77500.0 1192.6 1199.7 1215.1 1233.1 1252.2 15199.3 15584.1 15611.3 15874.1 15976.8 32450.2 33628.0 34186.0 34420.8 34878.8 48493.3 48641.0 48696.5 48809.3 49476.5 7321.0 7438.6 7588.4 7605.5 7649.3 7516.6 9229.6 9799.3 10353.7 10726.0 9454.8 9811.4 9977.8 10086.3 10110.1 9481.5 9754.5 9822.0 10022.6 10036.2 8351.5 9436.2 9668.2 9862.2 9945.1 7201.0 7201.4 7218.1 7392.0 7461.1 7335.4 7893.0 9715.5 9963.5 10308.5 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#3] mootools.html Cycles:180 Average:5490.15 Median:6345.43 stddev:2783.32 (43.9%) stddev-sans-first:2773.62 14:24:09 INFO - PROCESS | 18187 | Values: 1337.2 1507.6 1527.0 1716.8 1863.3 6977.7 7639.5 7760.5 7766.8 7783.8 7473.7 7647.8 7648.9 7650.1 7650.4 1995.0 2259.6 2312.7 2322.8 2347.6 2342.2 2348.0 2356.5 2357.1 2357.6 2249.0 2324.2 2329.2 2331.1 2331.4 2296.2 2312.4 2362.2 2366.6 2366.7 2337.3 2349.6 2352.0 2365.3 2367.6 7880.0 7913.7 7914.9 7918.2 7926.2 4814.9 4937.8 4942.6 4973.3 4980.8 3263.3 3269.6 3335.9 3365.2 3402.4 1049.6 1051.5 1056.7 1068.1 1076.9 10820.0 10904.1 10983.8 11009.7 11011.1 4532.8 4538.1 4589.2 4606.9 4612.4 9384.6 9385.4 9395.2 9396.2 9398.5 4897.4 4930.6 4932.2 4942.7 4944.0 4445.3 4445.5 4447.9 4449.1 4451.2 3392.3 3437.2 3439.6 3719.3 3784.1 1234.3 1247.5 1248.8 1257.0 1258.0 1346.1 1347.7 1378.1 1389.5 1391.4 7091.4 7200.9 7207.0 7207.1 7222.6 1120.9 1132.5 1134.8 1137.4 1138.0 5849.2 5971.5 5983.3 5996.5 5998.3 8937.2 9302.7 9361.1 9435.7 9511.4 9199.1 9392.6 9401.7 9403.1 9405.7 7210.6 7214.8 7306.1 7341.2 7392.8 6931.5 6945.9 6974.1 6984.5 6987.8 7969.5 8065.1 8292.5 8307.1 8428.8 8443.2 8589.0 8601.8 8601.9 8610.0 6593.4 6772.6 6774.2 6776.3 6793.3 6599.3 7028.1 7259.6 7275.5 7332.2 6856.3 6930.7 6941.4 7016.6 7065.3 6814.9 6823.9 6824.2 6887.2 6969.5 6921.7 6936.5 6949.0 6949.1 6952.8 6283.7 6407.1 6428.4 6505.4 6506.5 6494.6 6535.8 6539.4 6540.5 6544.0 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#4] prototype.html Cycles:180 Average:5238.28 Median:5800.05 stddev:1552.35 (26.8%) stddev-sans-first:1512.67 14:24:09 INFO - PROCESS | 18187 | Values: 346.8 350.6 350.9 352.2 356.5 5889.2 5893.0 5896.2 5899.1 5906.5 5549.9 5596.4 5635.9 5805.3 5849.3 4572.7 4572.9 4578.1 4582.8 4589.4 4373.4 4575.5 4577.1 4591.1 4593.5 4401.4 4520.4 4536.9 4552.8 4556.8 4517.5 4528.8 4529.4 4536.0 4538.6 3998.7 4026.3 4028.2 4031.5 4035.1 5448.2 5527.8 5545.7 5560.4 5561.0 5239.7 5264.8 5273.3 5278.2 5285.5 6172.6 6187.4 6188.5 6190.8 6197.8 4414.4 4436.2 4441.4 4450.2 4450.5 6269.2 6430.2 6439.6 6440.8 6443.6 4549.5 4550.2 4554.6 4556.8 4562.9 4592.1 4600.7 4607.7 4609.3 4616.9 5247.3 5252.0 5257.9 5260.8 5271.2 6050.1 6218.9 6222.2 6224.7 6229.0 1611.6 1627.3 1629.6 1630.8 1633.1 1117.6 1128.6 1133.3 1150.6 1151.0 5779.4 5779.5 5781.2 5794.4 5797.4 6356.1 6389.8 6392.6 6400.0 6404.0 5692.9 5787.7 5789.8 5802.7 5942.1 3426.7 3441.9 3467.7 3482.7 3489.3 6717.5 6722.0 6733.9 6739.3 6746.1 6436.7 6606.5 6620.7 6642.4 6644.5 6753.4 6761.5 6764.5 6764.6 6765.3 6476.9 6485.0 6485.8 6488.7 6492.1 6252.6 6351.7 6365.6 6367.3 6374.3 6739.5 6745.9 6747.3 6752.1 6757.5 4463.0 4468.0 4500.6 4500.7 4509.5 6303.3 6477.7 6478.2 6479.3 6494.2 6302.4 6307.3 6308.6 6314.3 6316.7 6232.8 6252.0 6281.9 6293.4 6293.9 6080.4 6178.2 6187.6 6188.4 6203.6 6314.1 6314.7 6318.8 6326.1 6327.6 6120.5 6155.2 6162.6 6163.0 6164.8 14:24:09 INFO - PROCESS | 18187 | 14:24:09 INFO - PROCESS | 18187 | [#5] yui.html Cycles:180 Average:13578.86 Median:43220.68 stddev:14972.86 (34.6%) stddev-sans-first:14983.61 14:24:09 INFO - PROCESS | 18187 | Values: 696.5 760.8 775.9 782.4 819.5 13794.8 14035.4 14046.6 14048.4 14058.6 13166.1 13441.3 13540.5 13566.5 13573.5 669.6 680.5 797.8 815.0 815.3 792.1 814.3 817.7 819.2 820.0 842.3 843.9 844.2 844.5 845.0 692.4 821.9 836.8 839.7 840.8 611.9 618.0 618.1 619.1 621.1 13675.3 13720.7 13724.8 13755.7 13760.8 13187.7 13214.0 13398.5 13454.7 13610.5 10041.9 10157.9 10198.6 10218.6 10338.2 3604.8 3619.9 3629.4 3630.3 3738.7 45747.5 45941.0 45947.8 46043.5 46071.8 10678.7 10701.5 10757.7 10884.6 10895.6 19000.4 19007.4 19036.1 19065.7 19083.3 7444.7 7576.8 7632.9 7729.7 8068.3 4362.8 4370.7 4393.1 4434.3 4517.3 3101.9 3122.8 3128.0 3128.6 3144.4 561.0 561.9 563.5 597.6 624.8 621.0 681.2 713.1 719.6 724.2 9172.8 9330.6 9361.3 9508.0 9555.0 567.9 674.1 702.3 702.7 712.7 4106.3 4129.6 4134.0 4156.0 4244.5 51951.7 52869.0 53173.5 53378.0 54184.5 47821.3 48213.8 48613.3 48823.5 48905.0 43096.0 43189.8 43251.6 43829.1 44613.0 8240.3 8392.6 8414.0 8597.8 8610.6 32953.3 32966.8 33609.3 33847.2 34015.7 39803.2 40278.0 42885.0 44161.8 47064.8 11252.8 11378.4 11409.0 11616.6 11869.9 11803.5 12162.9 12389.9 12929.0 13036.2 11414.5 11487.5 11703.0 11893.9 12231.5 10940.7 11366.1 12022.6 12075.0 12101.0 11350.2 11547.4 11771.6 11936.1 12232.8 9763.5 9884.0 10227.7 10332.2 10577.9 9627.3 9659.3 10311.9 10357.9 10363.5 14:24:09 INFO - PROCESS | 18187 | -------- Summary: end -------- 14:24:09 INFO - PROCESS | 18187 | 14:24:10 INFO - TEST-INFO | 18187: exit 0 14:24:10 INFO - TEST-OK | dromaeo_css | took 1112557ms 14:24:10 INFO - TEST-START | kraken 14:24:10 INFO - operating with platform_type : linux_ 14:24:10 INFO - Initialising browser for kraken test... 14:24:10 INFO - TEST-INFO | started process 18373 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps4iU_U/profile http://localhost:56656/getInfo.html) 14:24:14 INFO - PROCESS | 18373 | __metrics Screen width/height:1600/1200 14:24:14 INFO - PROCESS | 18373 | colorDepth:24 14:24:14 INFO - PROCESS | 18373 | Browser inner width/height: 1024/697 14:24:14 INFO - PROCESS | 18373 | __metrics 14:24:14 INFO - PROCESS | 18373 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:15 INFO - TEST-INFO | 18373: exit 0 14:24:15 INFO - Browser initialized. 14:24:15 INFO - Running cycle 1/1 for kraken test... 14:24:15 INFO - TEST-INFO | started process 18452 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps4iU_U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:27 INFO - PROCESS | 18452 | RSS: Main: 153030656 14:24:27 INFO - PROCESS | 18452 | 14:24:29 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:30 INFO - PROCESS | 18452 | RSS: Main: 195149824 14:24:30 INFO - PROCESS | 18452 | 14:24:32 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-dft) 14:24:33 INFO - PROCESS | 18452 | RSS: Main: 184627200 14:24:33 INFO - PROCESS | 18452 | 14:24:36 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-fft) 14:24:37 INFO - PROCESS | 18452 | RSS: Main: 168353792 14:24:37 INFO - PROCESS | 18452 | 14:24:39 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56656/tests/kraken/driver.html?testName=audio-oscillator) 14:24:39 INFO - PROCESS | 18452 | RSS: Main: 167342080 14:24:39 INFO - PROCESS | 18452 | 14:24:41 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:42 INFO - PROCESS | 18452 | RSS: Main: 171163648 14:24:42 INFO - PROCESS | 18452 | 14:24:45 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:46 INFO - PROCESS | 18452 | RSS: Main: 170627072 14:24:46 INFO - PROCESS | 18452 | 14:24:49 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56656/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:50 INFO - PROCESS | 18452 | RSS: Main: 171196416 14:24:50 INFO - PROCESS | 18452 | 14:24:52 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56656/tests/kraken/driver.html?testName=json-parse-financial) 14:24:53 INFO - PROCESS | 18452 | RSS: Main: 170164224 14:24:53 INFO - PROCESS | 18452 | 14:24:55 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:55 INFO - PROCESS | 18452 | RSS: Main: 184311808 14:24:55 INFO - PROCESS | 18452 | 14:24:57 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:57 INFO - PROCESS | 18452 | RSS: Main: 180322304 14:24:57 INFO - PROCESS | 18452 | 14:25:00 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:00 INFO - PROCESS | 18452 | RSS: Main: 189370368 14:25:00 INFO - PROCESS | 18452 | 14:25:03 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:03 INFO - PROCESS | 18452 | RSS: Main: 195014656 14:25:03 INFO - PROCESS | 18452 | 14:25:06 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:06 INFO - PROCESS | 18452 | RSS: Main: 194785280 14:25:06 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | Cycle 1(1): loaded http://localhost:56656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56656/tests/kraken/driver.html?testName=ai-astar) 14:25:08 INFO - PROCESS | 18452 | RSS: Main: 254734336 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | __start_tp_report 14:25:08 INFO - PROCESS | 18452 | _x_x_mozilla_page_load 14:25:08 INFO - PROCESS | 18452 | _x_x_mozilla_page_load_details 14:25:08 INFO - PROCESS | 18452 | |i|pagename|runs| 14:25:08 INFO - PROCESS | 18452 | |0;ai-astar;108;111;105;108;111;110;100;109;110;111 14:25:08 INFO - PROCESS | 18452 | |1;audio-beat-detection;159;127;152;170;127;157;166;131;168;123 14:25:08 INFO - PROCESS | 18452 | |2;audio-dft;162;162;161;160;160;159;163;167;161;162 14:25:08 INFO - PROCESS | 18452 | |3;audio-fft;73;74;117;93;73;72;72;117;109;73 14:25:08 INFO - PROCESS | 18452 | |4;audio-oscillator;94;95;139;95;95;96;140;94;96;152 14:25:08 INFO - PROCESS | 18452 | |5;imaging-gaussian-blur;118;115;114;115;114;115;115;115;115;115 14:25:08 INFO - PROCESS | 18452 | |6;imaging-darkroom;147;145;146;145;146;145;145;146;145;145 14:25:08 INFO - PROCESS | 18452 | |7;imaging-desaturate;96;96;96;95;97;96;98;96;96;97 14:25:08 INFO - PROCESS | 18452 | |8;json-parse-financial;57;57;56;57;58;56;58;65;55;56 14:25:08 INFO - PROCESS | 18452 | |9;json-stringify-tinderbox;67;67;66;66;68;69;74;66;67;67 14:25:08 INFO - PROCESS | 18452 | |10;stanford-crypto-aes;84;85;86;85;85;87;85;84;85;86 14:25:08 INFO - PROCESS | 18452 | |11;stanford-crypto-ccm;119;117;119;117;112;117;123;122;123;121 14:25:08 INFO - PROCESS | 18452 | |12;stanford-crypto-pbkdf2;157;149;146;152;156;143;158;158;156;148 14:25:08 INFO - PROCESS | 18452 | |13;stanford-crypto-sha256-iterative;69;71;72;69;70;69;67;70;69;68 14:25:08 INFO - PROCESS | 18452 | __end_tp_report 14:25:08 INFO - PROCESS | 18452 | __start_cc_report 14:25:08 INFO - PROCESS | 18452 | _x_x_mozilla_cycle_collect,999 14:25:08 INFO - PROCESS | 18452 | __end_cc_report 14:25:08 INFO - PROCESS | 18452 | __startTimestamp1455056708780__endTimestamp 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | ------- Summary: start ------- 14:25:08 INFO - PROCESS | 18452 | Number of tests: 14 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.47 (3.2%) stddev-sans-first:3.67 14:25:08 INFO - PROCESS | 18452 | Values: 108.0 111.0 105.0 108.0 111.0 110.0 100.0 109.0 110.0 111.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:158.00 stddev:18.92 (12.0%) stddev-sans-first:19.65 14:25:08 INFO - PROCESS | 18452 | Values: 159.0 127.0 152.0 170.0 127.0 157.0 166.0 131.0 168.0 123.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:2.21 (1.4%) stddev-sans-first:2.35 14:25:08 INFO - PROCESS | 18452 | Values: 162.0 162.0 161.0 160.0 160.0 159.0 163.0 167.0 161.0 162.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#3] audio-fft Cycles:10 Average:87.30 Median:73.00 stddev:19.79 (27.1%) stddev-sans-first:20.31 14:25:08 INFO - PROCESS | 18452 | Values: 73.0 74.0 117.0 93.0 73.0 72.0 72.0 117.0 109.0 73.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:23.76 (25.0%) stddev-sans-first:24.53 14:25:08 INFO - PROCESS | 18452 | Values: 94.0 95.0 139.0 95.0 95.0 96.0 140.0 94.0 96.0 152.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:0.44 14:25:08 INFO - PROCESS | 18452 | Values: 118.0 115.0 114.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 14:25:08 INFO - PROCESS | 18452 | Values: 147.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 14:25:08 INFO - PROCESS | 18452 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 98.0 96.0 96.0 97.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.80 (4.9%) stddev-sans-first:2.96 14:25:08 INFO - PROCESS | 18452 | Values: 57.0 57.0 56.0 57.0 58.0 56.0 58.0 65.0 55.0 56.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.54 14:25:08 INFO - PROCESS | 18452 | Values: 67.0 67.0 66.0 66.0 68.0 69.0 74.0 66.0 67.0 67.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 14:25:08 INFO - PROCESS | 18452 | Values: 84.0 85.0 86.0 85.0 85.0 87.0 85.0 84.0 85.0 86.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:120.00 stddev:3.43 (2.9%) stddev-sans-first:3.64 14:25:08 INFO - PROCESS | 18452 | Values: 119.0 117.0 119.0 117.0 112.0 117.0 123.0 122.0 123.0 121.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:156.00 stddev:5.48 (3.5%) stddev-sans-first:5.54 14:25:08 INFO - PROCESS | 18452 | Values: 157.0 149.0 146.0 152.0 156.0 143.0 158.0 158.0 156.0 148.0 14:25:08 INFO - PROCESS | 18452 | 14:25:08 INFO - PROCESS | 18452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 14:25:08 INFO - PROCESS | 18452 | Values: 69.0 71.0 72.0 69.0 70.0 69.0 67.0 70.0 69.0 68.0 14:25:08 INFO - PROCESS | 18452 | -------- Summary: end -------- 14:25:08 INFO - PROCESS | 18452 | 14:25:09 INFO - TEST-INFO | 18452: exit 0 14:25:09 INFO - TEST-OK | kraken | took 59024ms 14:25:09 INFO - SUITE-END | took 1171s 14:25:09 INFO - Completed test suite (00:19:31) 14:25:09 INFO - Working with test: dromaeo_css 14:25:09 INFO - Generating results file: dromaeo_css 14:25:09 INFO - Working with test: kraken 14:25:09 INFO - Generating results file: kraken 14:25:09 INFO - javascript benchmark 14:25:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:25:10 INFO - process_Request line: dromaeo_css 6910.66 graph.html#tests=[[72,64,35]] 14:25:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:10 INFO - process_Request line: kraken 1522.90 graph.html#tests=[[232,64,35]] 14:25:10 INFO - RETURN: dromaeo_css: 6910.66 14:25:10 INFO - RETURN: kraken: 1522.90 14:25:10 INFO - javascript benchmark 14:25:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.5611614373993, 3156.7948083374595, 3211.0366889933016, 3216.7909085909428, 3237.514372844073, 5204.245384419257, 5239.161734122541, 5260.605454590906, 5311.893762124755, 5365.195220716894, 5225.111731005729, 5251.054810134175, 5303.310569625944, 5345.412004679482, 5363.034653762321, 4829.541193586612, 4848.6848354857, 4857.198562237227, 4900.901981960359, 4964.329815474919, 4869.293952376921, 4926.8392255263725, 5006.749662516878, 5039.118154322997, 5056.519630635084, 4796.5683088521855, 4861.0277944411255, 4914.827981020683, 4916.459189489154, 4984.0, 4783.7129772213775, 4825.541573550507, 4836.830710925136, 4851.393575803025, 4871.464138944749, 4860.586850117745, 4863.17326054568, 4868.805247790084, 4869.050535145648, 4871.926921096187, 5042.773075211624, 5124.92312615311, 5131.384233891919, 5143.0, 5194.948050519484, 5668.376478587352, 5683.9715801420725, 5684.573656975744, 5689.800856970028, 5692.971535142339, 5698.800541981052, 5716.514096301819, 5718.0, 5722.456366645204, 5724.627899186539, 5275.261463395128, 5322.0, 5356.758945847408, 5400.0, 5472.972635136799, 5840.824775256664, 5848.941510584839, 5859.707014649251, 5883.764649413975, 5903.58674892762, 5640.407757185437, 5642.915356269659, 5644.6330988485615, 5644.97177514118, 5649.548036157097, 5647.632903861236, 5677.318721753416, 5718.885622287531, 5743.0, 5797.565182611321, 5684.232628595169, 5688.40271771458, 5689.9146512802345, 5694.316681998187, 5700.743466544015, 5403.83788486346, 5641.153826925994, 5695.7152142392715, 5699.059655156852, 5705.971470142623, 4385.0, 4387.802548885244, 4414.646828253732, 4417.602415782595, 4455.443069616298, 3958.4853968984426, 3961.1483531040963, 3978.701597380208, 3983.4024896265214, 4005.8998525036523, 5226.5818734501145, 5295.338082739658, 5317.574594032468, 5326.255606387906, 5332.493413125747, 5703.973284808774, 5708.315002199763, 5726.656400615976, 5728.312602487645, 5760.6543607382855, 5219.739013049332, 5289.523942845162, 5290.444503327172, 5290.841274761763, 5295.7087360195555, 4710.552497512731, 4757.119932812441, 4793.760311984387, 4799.088173247072, 4843.104025755247, 5913.438223368859, 5921.496672782861, 5923.407659234128, 5924.7333869975955, 5928.170056192136, 5664.830055098354, 5664.85837854057, 5666.15007748841, 5667.603267771216, 5688.687122208318, 5788.044972579477, 5872.55955803325, 5876.500497457593, 5898.911516327173, 5986.970065149646, 5581.6371935824045, 5582.5533957282505, 5583.022970979981, 5583.581231407742, 5589.049861523632, 5630.127330263652, 5645.802396916089, 5662.943370566241, 5675.120356344773, 5707.68607726579, 5488.643238189505, 5583.944160558505, 5585.5531557476115, 5637.915431268452, 5679.0345641240265, 5602.635828671123, 5605.467480589337, 5606.495415412633, 5606.551475882001, 5608.10270356741, 5422.891542169055, 5529.695866727368, 5535.169724541351, 5540.944590554042, 5542.2795036644975, 5546.278983732089, 5564.4713752193475, 5620.297462817148, 5624.493795558419, 5669.461401166883, 5490.176473529003, 5490.91763623538, 5499.175123731472, 5506.476884696108, 5516.089845175501], "unit": "score", "name": "dojo.html", "value": 5256.306395757668}, {"lowerIsBetter": false, "replicates": [519.0320053100968, 530.4562823106313, 548.4926443040187, 549.0693274899045, 567.4297331182163, 35920.0, 36854.447183292235, 37015.44476832843, 37016.81491592538, 37065.0, 40023.399649005216, 40669.0, 40683.186336273255, 40704.185916281654, 40886.182276354455, 8339.791505212357, 8479.406441549094, 8553.871691924625, 8557.786055348635, 8560.657573697044, 8509.0, 8714.172153645426, 8728.258098061673, 8735.126487351277, 8736.21374076333, 8610.397272190949, 8787.824243515126, 8799.912000879973, 8805.119488051176, 8815.074417186168, 8668.089850565695, 8705.695300664509, 8751.474911505331, 8759.912400876005, 8761.08008659088, 8582.399232053758, 8697.478151310941, 8732.51971141587, 8735.43219690718, 8742.169493898069, 40645.79677101596, 40854.59145408538, 40863.0, 40892.18215635671, 40894.591054089375, 3168.714815666578, 3559.0, 3622.275544891006, 3811.9809400952818, 3991.0, 29800.254993625116, 30010.24974375636, 30064.248393790112, 30244.0, 31010.534841977387, 4029.4157347184787, 4036.777977211252, 4065.79671016448, 4084.5915408459214, 4168.854090106862, 264795.0, 268072.0, 268417.0, 268862.0, 269102.0, 51827.74086129621, 52567.21149182766, 57848.0, 58141.0, 60358.0, 53986.46013539814, 54063.0, 54179.45820541823, 54310.728446358306, 54338.728306358214, 14637.121772693672, 14798.408063677332, 14956.92521537407, 14965.401383944738, 14970.0, 10025.14786243163, 11099.500522476508, 11365.09079273656, 11788.882111178778, 11907.464164112636, 19860.10629521675, 20328.0, 20502.58994820095, 20514.487137821674, 20555.177792888415, 7325.377342925804, 7469.58917259556, 7518.924810751932, 7528.096628404626, 7528.661210245552, 1003.8895721470633, 1005.5374527717332, 1018.6485662446444, 1051.8895515970867, 1136.3522792008641, 29222.269443263664, 29593.55609665857, 29609.555856662166, 30087.0, 30142.397152056838, 1070.175964507325, 1079.6005477973042, 1154.7517283784027, 1228.5515786737956, 1236.975260494785, 15614.0, 15627.398454095764, 15664.843351566338, 15778.76331855023, 16006.439774608065, 317061.0, 319536.21855125536, 319983.0, 320524.0, 321405.0, 43703.78148109239, 49650.75174624104, 52886.73556632192, 53077.7346113267, 53413.73293133509, 1310.960671179866, 1316.6642506160867, 1327.973440531184, 1354.1604205392719, 1356.125299182022, 28011.159665210078, 29093.0, 29378.11865644034, 29855.552166717083, 30212.5468117974, 41462.79268603758, 44634.10731785411, 47087.529124708315, 48371.5162848367, 48436.51563484461, 193217.0, 196802.0, 197138.0, 197615.0, 197697.0, 27554.448911022067, 27780.722192778623, 27873.44253114967, 27901.58147627828, 27912.720872791826, 36930.0, 38192.42711359276, 38288.80855595704, 40092.3986140214, 41986.79006604947, 34367.82816085903, 34863.47704784481, 35318.82340588281, 35897.64102359048, 35918.0, 35046.47430288497, 35412.82293588515, 35721.642783571835, 35978.46032309465, 36302.636973629924, 33694.0, 34424.31151377009, 34493.655063450045, 34674.47988280228, 34738.305233895684, 30071.0, 32063.198420039687, 32352.514712279804, 32633.18417039593, 32769.50845737364, 25272.87363563244, 25643.743562564134, 25867.482650346512, 25996.480070398866, 26146.215613531625], "unit": "score", "name": "ext.html", "value": 18099.341312908706}, {"lowerIsBetter": false, "replicates": [359.3029522725913, 365.37703216016695, 368.88748931575867, 369.12517333918606, 374.9906252343693, 13292.335383230848, 13851.30743462828, 16427.4250401236, 17021.57446063849, 17915.104244787773, 15166.469173578927, 15647.374105035813, 15674.294656740445, 15903.0, 17060.82939170608, 5322.92015619767, 5450.509454149126, 5488.451154884519, 5489.560835133199, 5490.670559766407, 3991.0621004064024, 5415.404305526389, 5662.150677398382, 5901.5278777697895, 5925.466707996279, 5742.569307301948, 5798.159266906296, 5852.531797456215, 5892.587518873681, 5912.467877890989, 5865.501432378253, 5879.882402351972, 5880.147378630075, 5885.85285367865, 5888.087346461284, 5086.084504789136, 5110.565601923841, 5129.794808207667, 5134.768935397916, 5186.1442861927735, 19709.11308991099, 20045.79954200454, 20193.19227230909, 20216.898915505328, 20317.18731250748, 2216.7007453993665, 2218.4810328339254, 2277.1802151225547, 2334.0197117210814, 2356.2106694257445, 12018.0, 12770.042246831432, 12804.871951280555, 12826.166299190523, 13260.336983150804, 1845.713914343279, 1899.0, 1916.051554480541, 1931.652302585534, 1941.7864034956144, 53731.73134134343, 60231.69884150595, 60355.698221509054, 62031.379686203014, 62532.06201906975, 9794.902050979399, 9932.404055756677, 9989.900100999042, 10025.699229023141, 10082.59669613222, 13218.60344189676, 13267.076273940225, 13295.0, 13296.534621288209, 13298.135621184592, 7205.495615306878, 7312.817179570447, 7333.669984850588, 7335.376492998155, 7367.373773229228, 7057.647117644097, 7068.434525237969, 7199.532030418006, 7273.490855640054, 7275.854482910418, 4125.958740412558, 4318.093200427946, 4461.620762235181, 4466.531014243523, 4539.614132798749, 1837.9724304135448, 1840.1144960130873, 1840.9355672551396, 1844.5112045308003, 1851.7685289338833, 942.1002942190192, 957.4159762544842, 976.4483067067084, 990.0396615283164, 1055.2718624149466, 12820.93589532065, 15202.087874727551, 15701.450449234222, 16717.83282167187, 16780.496585102468, 894.1550235027836, 1000.4247557654378, 1016.5425558498705, 1053.8893416191343, 1097.3909480238385, 9162.954185229031, 9306.395084319498, 9321.953390233006, 9493.240540756722, 9494.382865113745, 379976.0, 437205.0, 460410.0, 502858.0, 538302.0, 75579.62210189024, 76235.0, 76620.61689691516, 76990.0, 77500.0, 1192.6243233381458, 1199.7120691034263, 1215.1493954231896, 1233.0936761480305, 1252.2423933520272, 15199.316030778862, 15584.142872142142, 15611.297491612677, 15874.126923019345, 15976.840231598, 32450.18874528061, 33628.0, 34186.0, 34420.82789586136, 34878.82560587181, 48493.272600910306, 48641.0, 48696.5130348692, 48809.2678609814, 49476.50523494719, 7321.048263725682, 7438.623854586919, 7588.392928565591, 7605.467617266738, 7649.349805266392, 7516.624168791648, 9229.584668689791, 9799.314048016571, 10353.689389318333, 10726.0, 9454.810903782023, 9811.362261452983, 9977.800443990935, 10086.344387614781, 10110.09009189147, 9481.478518681539, 9754.512274386394, 9821.950890245504, 10022.599096036078, 10036.197104231498, 8351.498910065415, 9436.245100392089, 9668.178204852666, 9862.161716254199, 9945.126209717477, 7201.0, 7201.3518783309755, 7218.061651985208, 7392.0, 7461.104667439942, 7335.372311468563, 7893.0, 9715.514224288898, 9963.50182490858, 10308.536115874653], "unit": "score", "name": "jquery.html", "value": 8304.198087489527}, {"lowerIsBetter": false, "replicates": [1337.197681391166, 1507.6080219143023, 1526.9694606107876, 1716.7596536484887, 1863.329201487465, 6977.720891164354, 7639.541627502354, 7760.456768026241, 7766.766996990085, 7783.844323113534, 7473.701051957915, 7647.847043059135, 7648.885266721004, 7650.120236172842, 7650.4262180336555, 1994.9900250498727, 2259.638457846745, 2312.745597984229, 2322.837401381904, 2347.612643913752, 2342.2153578551206, 2347.9882600586975, 2356.5051339218785, 2357.068957761683, 2357.6227803551437, 2248.9887550562225, 2324.1865347128537, 2329.1964272326104, 2331.067572970817, 2331.4171457135717, 2296.1848543766973, 2312.387217387394, 2362.161432691387, 2366.621340585515, 2366.6568347589673, 2337.322176568793, 2349.612313968193, 2352.023910077316, 2365.3022358404314, 2367.5856725073045, 7880.0, 7913.683452661944, 7914.920850791476, 7918.168592297841, 7926.167752386032, 4814.927776083362, 4937.777799998973, 4942.604591632697, 4973.303737476756, 4980.800767969313, 3263.298390845956, 3269.623993240784, 3335.8999230023137, 3365.2428203654226, 3402.4045791986305, 1049.6273822792875, 1051.4952822645173, 1056.6618682021756, 1068.1401471815186, 1076.8869268726748, 10820.0, 10904.073153781937, 10983.835242471368, 11009.669709908796, 11011.119110471143, 4532.750698711537, 4538.069695712371, 4589.2198326284615, 4606.930896036562, 4612.377329060601, 9384.624615015324, 9385.38994965325, 9395.248380129573, 9396.154346108882, 9398.48308343034, 4897.436794768576, 4930.556249937523, 4932.210846264652, 4942.703437793743, 4943.975280123648, 4445.26653102241, 4445.488768791631, 4447.888027993002, 4449.1101779644205, 4451.1765323415275, 3392.3215356928713, 3437.1750779813165, 3439.5872495300723, 3719.330520506335, 3784.110733977513, 1234.3149551998727, 1247.5134697467995, 1248.818921256431, 1257.0006844558598, 1258.031315886762, 1346.0712108645005, 1347.7439286535528, 1378.1042322490262, 1389.534505940501, 1391.436468230348, 7091.3972312353, 7200.855982880313, 7207.0, 7207.063081799437, 7222.566646001257, 1120.9495572699248, 1132.5073592986912, 1134.7900638381925, 1137.4085475552665, 1137.9943100284445, 5849.181114643953, 5971.462568368867, 5983.341832398432, 5996.4603185713495, 5998.340182579913, 8937.195652391316, 9302.720918372459, 9361.063893610584, 9435.716928492157, 9511.429314241168, 9199.080091990747, 9392.577334019848, 9401.717948461557, 9403.059694030542, 9405.670801521914, 7210.639468026578, 7214.783556493314, 7306.050213472215, 7341.229170937081, 7392.778216653509, 6931.514793964576, 6945.895811562932, 6974.128233970754, 6984.476164287597, 6987.790366289019, 7969.521828690297, 8065.112837587743, 8292.502449853027, 8307.127751585997, 8428.831423371621, 8443.155684431753, 8589.0, 8601.784955375915, 8601.913980860361, 8610.0, 6593.3736295051895, 6772.627505487246, 6774.153230846145, 6776.28848970851, 6793.252742198255, 6599.274079851117, 7028.121484814398, 7259.637018148966, 7275.454340924346, 7332.156801967629, 6856.314368563104, 6930.653467326714, 6941.409980151541, 7016.614086225102, 7065.328793764585, 6814.8637027260165, 6823.863522729617, 6824.18109826824, 6887.173539175331, 6969.512134150561, 6921.688524016331, 6936.4797640176175, 6949.0, 6949.131358580177, 6952.826179345557, 6283.717232724447, 6407.135036769976, 6428.4214420702365, 6505.447037001908, 6506.512011599244, 6494.610323380423, 6535.836604084936, 6539.411452969255, 6540.542162048611, 6544.0], "unit": "score", "name": "mootools.html", "value": 4562.733959944145}, {"lowerIsBetter": false, "replicates": [346.7659329952282, 350.6160753974399, 350.8842082112903, 352.23213394799325, 356.4759803089459, 5889.234399528055, 5893.0, 5896.204012458322, 5899.144624029514, 5906.497947674442, 5549.944500555003, 5596.356419011815, 5635.943640563593, 5805.3323867755225, 5849.2980842298875, 4572.657050721193, 4572.885677858047, 4578.061497393043, 4582.793774280157, 4589.357489951392, 4373.365861950016, 4575.496695363524, 4577.130345234412, 4591.127685739715, 4593.5406459354135, 4401.449818772653, 4520.434945631796, 4536.9092618147615, 4552.795124219418, 4556.817727290904, 4517.4579050513985, 4528.818847246106, 4529.365888775574, 4536.024754677744, 4538.568835960578, 3998.7400818946967, 4026.315526360526, 4028.194361127757, 4031.475908131924, 4035.0921042765435, 5448.237246785453, 5527.751251193706, 5545.72271386429, 5560.36055853578, 5561.026820306471, 5239.685618862881, 5264.815101732776, 5273.34083239595, 5278.155495120763, 5285.524302812727, 6172.567920245585, 6187.350328215518, 6188.47397971173, 6190.783322583688, 6197.783077592308, 4414.359917811931, 4436.201483732927, 4441.400410944513, 4450.198964186445, 4450.465944086698, 6269.2476902771505, 6430.196225471816, 6439.613623182624, 6440.774572889926, 6443.613383196976, 4549.499555048942, 4550.226461501553, 4554.612857907049, 4556.84051058218, 4562.885927851764, 4592.127495775792, 4600.7469589172915, 4607.746573938399, 4609.3086037094035, 4616.907661846744, 5247.291615631917, 5251.973740131351, 5257.921131183035, 5260.842174734764, 5271.156614941591, 6050.092486127028, 6218.875622487525, 6222.222222222223, 6224.719887604978, 6229.0, 1611.5971007248188, 1627.2758622413148, 1629.5600187949424, 1630.8287629798938, 1633.1099550744873, 1117.5697356517637, 1128.5542210826677, 1133.2633788037842, 1150.5685367987005, 1150.9712257193637, 5779.422057794187, 5779.450952159538, 5781.219535362757, 5794.449527294901, 5797.449242321973, 6356.078368636522, 6389.7539979703515, 6392.616443013434, 6400.039994000937, 6404.039394090923, 5692.886142277214, 5787.71061446926, 5789.768409263583, 5802.65184088956, 5942.10868369748, 3426.7087297579487, 3441.8795342162903, 3467.6705712957228, 3482.7039701625645, 3489.3021395720957, 6717.462602991749, 6722.0, 6733.8653226935185, 6739.292374300726, 6746.089277947414, 6436.742530298736, 6606.537542371988, 6620.735170593122, 6642.368974947372, 6644.468442524683, 6753.425958793459, 6761.526693131434, 6764.526483146231, 6764.5603035802515, 6765.323467653196, 6476.902846457213, 6484.967575162094, 6485.77299794505, 6488.675566221765, 6492.091107244895, 6252.5935814171935, 6351.745930162741, 6365.61806291624, 6367.331430199948, 6374.3306952771145, 6739.494537909578, 6745.898811517929, 6747.291534388818, 6752.054712340178, 6757.493188011017, 4463.0, 4467.955320446754, 4500.594946454704, 4500.662450316174, 4509.458864936098, 6303.338149494237, 6477.676116194266, 6478.222613286436, 6479.287278399278, 6494.188226471691, 6302.401271879347, 6307.274663413767, 6308.558400912076, 6314.273858506331, 6316.684165791784, 6232.781852635136, 6252.0, 6281.874362512815, 6293.37066293367, 6293.874122517615, 6080.391960803884, 6178.165947597017, 6187.628742275478, 6188.44304012641, 6203.627782333075, 6314.147590075465, 6314.652694101868, 6318.842028949313, 6326.114343991937, 6327.620342779448, 6120.510359171167, 6155.230596175478, 6162.599431036968, 6163.044728067157, 6164.7670465907895], "unit": "score", "name": "prototype.html", "value": 4745.520996901162}, {"lowerIsBetter": false, "replicates": [696.4880812602739, 760.8136006678363, 775.8603451378754, 782.4014628808962, 819.4960099538778, 13794.793078103836, 14035.36840842162, 14046.578602641912, 14048.43806247749, 14058.64853378666, 13166.144200626952, 13441.32793360333, 13540.526081587146, 13566.457341706344, 13573.457061717545, 669.638395266558, 680.5270337115682, 797.7965618767221, 814.9877751833727, 815.2744057788543, 792.1088775127981, 814.3322475570035, 817.697451942782, 819.2381085590398, 819.9508029518248, 842.2588122452233, 843.9071702112763, 844.1516276142469, 844.543946269014, 845.0028965820329, 692.3561088187984, 821.8849361089423, 836.8033512124646, 839.7186942374251, 840.8276303357796, 611.8653896142841, 617.9567430279837, 618.1376979114156, 619.0590302739855, 621.0870021069021, 13675.31623418825, 13720.725585488333, 13724.794128088086, 13755.656108597264, 13760.793588096187, 13187.73624527504, 13214.0, 13398.464061437531, 13454.730905381935, 13610.455581776718, 10041.899581004243, 10157.898421015769, 10198.643047493302, 10218.642347517876, 10338.172946164364, 3604.819759012039, 3619.8733044343585, 3629.4192929131214, 3630.3465376232266, 3738.6635202831603, 45747.54252457466, 45941.0, 45947.77026114848, 46043.53956460426, 46071.76964115158, 10678.73303167427, 10701.518431670593, 10757.677269681923, 10884.564617415215, 10895.564177432814, 19000.429987100408, 19007.42977710671, 19036.143373548224, 19065.714014289795, 19083.332083377016, 7444.702211911463, 7576.772696819105, 7632.885506717404, 7729.652165652559, 8068.273855353046, 4362.781860906942, 4370.7159034662645, 4393.121375724868, 4434.312681534368, 4517.34498497716, 3101.9069427917198, 3122.7970181938103, 3127.9530807037913, 3128.6402063762503, 3144.3868445653334, 560.9523190528769, 561.9213310136585, 563.5491606714612, 597.5787070115558, 624.7969409941787, 620.9815901920854, 681.2234053179379, 713.0836874616093, 719.6365835253164, 724.199759266014, 9172.816543669223, 9330.58012389444, 9361.297902657328, 9508.0, 9554.952225238829, 567.890797881595, 674.069783698493, 702.2731472925498, 702.6556987076295, 712.6757325416922, 4106.322456794655, 4129.561507867326, 4133.979330103391, 4155.97922010388, 4244.490661120685, 51951.740241298554, 52869.0, 53173.46826531685, 53378.0, 54184.45815541873, 47821.28268075982, 48213.75893120512, 48613.270800938015, 48823.511764882605, 48905.0, 43096.0, 43189.78405108017, 43251.56748432538, 43829.12341753211, 44613.0, 8240.299574536231, 8392.622331995197, 8414.0, 8597.785055373666, 8610.569471526273, 32953.34093318168, 32966.83516582402, 33609.327813444084, 33847.153821154665, 34015.65984340125, 39803.20393592054, 40278.0, 42885.0, 44161.77919110384, 47064.7646761764, 11252.774944501229, 11378.43107844621, 11409.0, 11616.593419230287, 11869.881301186877, 11803.527858885549, 12162.878371216175, 12389.876101238871, 12929.0, 13036.217826930415, 11414.543418263176, 11487.540498380306, 11703.0, 11893.881061189624, 12231.510739570673, 10940.671779846618, 11366.090712743126, 12022.643543894497, 12075.0, 12100.971417429266, 11350.205485615928, 11547.364894930859, 11771.646850594496, 11936.10479214045, 12232.75534489323, 9763.463009534544, 9884.0, 10227.693169204937, 10332.17342612574, 10577.894221057999, 9627.304592351999, 9659.32384733062, 10311.948440257751, 10357.896421035693, 10363.533640986325], "unit": "score", "name": "yui.html", "value": 6366.943099533997}], "name": "dromaeo_css", "value": 6910.661993588712}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 108.0, 111.0, 110.0, 100.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 152.0, 170.0, 127.0, 157.0, 166.0, 131.0, 168.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 159.0, 163.0, 167.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 117.0, 93.0, 73.0, 72.0, 72.0, 117.0, 109.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 139.0, 95.0, 95.0, 96.0, 140.0, 94.0, 96.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 98.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 56.0, 58.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 69.0, 74.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 85.0, 85.0, 87.0, 85.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 119.0, 117.0, 112.0, 117.0, 123.0, 122.0, 123.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [157.0, 149.0, 146.0, 152.0, 156.0, 143.0, 158.0, 158.0, 156.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 72.0, 69.0, 70.0, 69.0, 67.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1522.9}]} 14:25:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1522.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6910.66"}}} 14:25:10 INFO - Return code: 0 14:25:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:10 INFO - # TBPL SUCCESS # 14:25:10 INFO - Running post-action listener: _resource_record_post_action 14:25:10 INFO - Running post-run listener: _resource_record_post_run 14:25:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 36864; Write bytes: 528072704; Read time: 380; Write time: 471232 14:25:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 32768; Write bytes: 240156672; Read time: 156; Write time: 231984 14:25:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287916032; Read time: 224; Write time: 239248 14:25:11 INFO - Running post-run listener: _upload_blobber_files 14:25:11 INFO - Blob upload gear active. 14:25:11 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:25:11 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 14:25:11 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'] 14:25:11 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 14:25:11 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:12 INFO - (blobuploader) - INFO - Done attempting. 14:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:13 INFO - (blobuploader) - INFO - Done attempting. 14:25:13 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:13 INFO - Return code: 0 14:25:13 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:25:13 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed351403821222004ad02d19cb4c1d42f962f22ee06205ad41668907fa3f6cc88a100d48f98e96e12e749dfbf17fbeb288e7356596895e6466f519826af8a509", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5ef83cf2d00d4c2fe43138e876cb94a79b4975daa60b108b7c56caf067ba06ac7155854c3a8c6f71da5fe71f55e12340151be1513b34d277e12859635ce887"} 14:25:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:25:13 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:25:13 INFO - Contents: 14:25:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed351403821222004ad02d19cb4c1d42f962f22ee06205ad41668907fa3f6cc88a100d48f98e96e12e749dfbf17fbeb288e7356596895e6466f519826af8a509", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5ef83cf2d00d4c2fe43138e876cb94a79b4975daa60b108b7c56caf067ba06ac7155854c3a8c6f71da5fe71f55e12340151be1513b34d277e12859635ce887"} 14:25:13 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:13 INFO - Copying logs to upload dir... 14:25:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:25:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.540267 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-02-09 14:25:13.367992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 14:25:13.371860) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 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/ed351403821222004ad02d19cb4c1d42f962f22ee06205ad41668907fa3f6cc88a100d48f98e96e12e749dfbf17fbeb288e7356596895e6466f519826af8a509", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5ef83cf2d00d4c2fe43138e876cb94a79b4975daa60b108b7c56caf067ba06ac7155854c3a8c6f71da5fe71f55e12340151be1513b34d277e12859635ce887"} build_url:https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/THc_UHj8T0mzjnHouNuqjg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed351403821222004ad02d19cb4c1d42f962f22ee06205ad41668907fa3f6cc88a100d48f98e96e12e749dfbf17fbeb288e7356596895e6466f519826af8a509", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5ef83cf2d00d4c2fe43138e876cb94a79b4975daa60b108b7c56caf067ba06ac7155854c3a8c6f71da5fe71f55e12340151be1513b34d277e12859635ce887"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 14:25:13.396724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:25:13.397042) ========= 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=1b9da9da7504fe468691862d000001b9-1455045452.372944-1129488440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 14:25:13.483337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 14:25:13.483931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 14:25:13.484596) ========= ========= Total master_lag: 0.31 =========