builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1458290310.31 results: success (0) buildid: 20160317203056 builduid: c9af4ecd30574fb6ba4410d73c46a263 revision: d9cc905f0f37faa8d1da6e449709d261eda4933b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.311972) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.312473) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.312791) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006453 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.336879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.337418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.350593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.350941) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.400289) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.400556) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.400911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.401197) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 01:38:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-03-18 01:38:31 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.504940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.505225) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.558706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:30.559010) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9cc905f0f37faa8d1da6e449709d261eda4933b --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 d9cc905f0f37faa8d1da6e449709d261eda4933b --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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 01:38:31,803 truncating revision to first 12 chars 2016-03-18 01:38:31,803 Setting DEBUG logging. 2016-03-18 01:38:31,803 attempt 1/10 2016-03-18 01:38:31,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9cc905f0f37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 01:38:32,074 unpacking tar archive at: fx-team-d9cc905f0f37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:31.146494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:31.146823) ========= echo d9cc905f0f37faa8d1da6e449709d261eda4933b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd9cc905f0f37faa8d1da6e449709d261eda4933b'] 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d9cc905f0f37faa8d1da6e449709d261eda4933b program finished with exit code 0 elapsedTime=0.004105 script_repo_revision: 'd9cc905f0f37faa8d1da6e449709d261eda4933b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:31.196583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:31.196871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:38:31.206994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-18 01:38:31.207421) ========= /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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:38:32 INFO - MultiFileLogger online at 20160318 01:38:32 in /builds/slave/test-pgo 01:38:32 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 01:38:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:38:32 INFO - {'append_to_log': False, 01:38:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:38:32 INFO - 'blob_upload_branch': 'Fx-Team', 01:38:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:38:32 INFO - 'branch': 'Fx-Team', 01:38:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:38:32 INFO - 'config_files': ('talos/linux_config.py',), 01:38:32 INFO - 'default_actions': ('clobber', 01:38:32 INFO - 'read-buildbot-config', 01:38:32 INFO - 'download-and-extract', 01:38:32 INFO - 'populate-webroot', 01:38:32 INFO - 'create-virtualenv', 01:38:32 INFO - 'install', 01:38:32 INFO - 'run-tests'), 01:38:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:38:32 INFO - 'download_minidump_stackwalk': True, 01:38:32 INFO - 'download_symbols': 'ondemand', 01:38:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:38:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:38:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:38:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:38:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:38:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:38:32 INFO - 'installer_path': 'installer.exe', 01:38:32 INFO - 'log_level': 'info', 01:38:32 INFO - 'log_name': 'talos', 01:38:32 INFO - 'log_to_console': True, 01:38:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:38:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:38:32 INFO - 'opt_config_files': (), 01:38:32 INFO - 'pip_index': False, 01:38:32 INFO - 'sps_profile': False, 01:38:32 INFO - 'sps_profile_interval': 0, 01:38:32 INFO - 'suite': 'dromaeojs', 01:38:32 INFO - 'system_bits': '32', 01:38:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:38:32 INFO - 'title': 'talos-linux64-ix-069', 01:38:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:38:32 INFO - 'use_talos_json': True, 01:38:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:38:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:38:32 INFO - 'work_dir': 'build'} 01:38:32 INFO - ##### 01:38:32 INFO - ##### Running clobber step. 01:38:32 INFO - ##### 01:38:32 INFO - Running pre-action listener: _resource_record_pre_action 01:38:32 INFO - Running main action method: clobber 01:38:32 INFO - rmtree: /builds/slave/test-pgo/build 01:38:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:38:33 INFO - Running post-action listener: _resource_record_post_action 01:38:33 INFO - ##### 01:38:33 INFO - ##### Running read-buildbot-config step. 01:38:33 INFO - ##### 01:38:33 INFO - Running pre-action listener: _resource_record_pre_action 01:38:33 INFO - Running main action method: read_buildbot_config 01:38:33 INFO - Using buildbot properties: 01:38:33 INFO - { 01:38:33 INFO - "project": "", 01:38:33 INFO - "product": "firefox", 01:38:33 INFO - "script_repo_revision": "production", 01:38:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:38:33 INFO - "repository": "", 01:38:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:38:33 INFO - "buildid": "20160317203056", 01:38:33 INFO - "pgo_build": "True", 01:38:33 INFO - "basedir": "/builds/slave/test-pgo", 01:38:33 INFO - "buildnumber": 1010, 01:38:33 INFO - "slavename": "talos-linux64-ix-069", 01:38:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:38:33 INFO - "platform": "ubuntu64_hw", 01:38:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:38:33 INFO - "branch": "fx-team", 01:38:33 INFO - "repo_path": "integration/fx-team", 01:38:33 INFO - "revision": "d9cc905f0f37faa8d1da6e449709d261eda4933b", 01:38:33 INFO - "stage_platform": "linux64-pgo", 01:38:33 INFO - "builduid": "c9af4ecd30574fb6ba4410d73c46a263", 01:38:33 INFO - "slavebuilddir": "test" 01:38:33 INFO - } 01:38:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:38:33 INFO - Running post-action listener: _resource_record_post_action 01:38:33 INFO - ##### 01:38:33 INFO - ##### Running download-and-extract step. 01:38:33 INFO - ##### 01:38:33 INFO - Running pre-action listener: _resource_record_pre_action 01:38:33 INFO - Running main action method: download_and_extract 01:38:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:33 INFO - https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:38:33 INFO - Downloaded 1361 bytes. 01:38:33 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:38:33 INFO - Using the following test package requirements: 01:38:33 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:38:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:38:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:38:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'jsshell-linux-x86_64.zip'], 01:38:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:38:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:38:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:38:33 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:38:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:38:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:38:33 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:38:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:33 INFO - https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:38:34 INFO - Downloaded 23579136 bytes. 01:38:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:38:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:38:36 INFO - Return code: 0 01:38:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:38: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')]} 01:38:36 INFO - https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:38:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:38:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:38:37 INFO - Downloaded 23579136 bytes. 01:38:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:38:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:38:39 INFO - Return code: 0 01:38:39 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')]} 01:38:39 INFO - https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:38:40 INFO - Downloaded 10846565 bytes. 01:38:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:38:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:38:40 INFO - Return code: 0 01:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:40 INFO - https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:38:42 INFO - Downloaded 57614061 bytes. 01:38:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:38:42 INFO - mkdir: /builds/slave/test-pgo/properties 01:38:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:38:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:38:42 INFO - Contents: 01:38:42 INFO - build_url:https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:38:42 INFO - Running post-action listener: _resource_record_post_action 01:38:42 INFO - Running post-action listener: set_extra_try_arguments 01:38:42 INFO - ##### 01:38:42 INFO - ##### Running populate-webroot step. 01:38:42 INFO - ##### 01:38:42 INFO - Running pre-action listener: _resource_record_pre_action 01:38:42 INFO - Running main action method: populate_webroot 01:38:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:38:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:38:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:38:42 INFO - '--tppagecycles', 01:38:42 INFO - '7'], 01:38:42 INFO - 'tests': ['tsvgm']}}, 01:38:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:38:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:38:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:38:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:38:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'tests': ['damp', 'tps']}, 01:38:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['damp', 'tps']}, 01:38:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:38:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:38:42 INFO - 'other': {'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'other_l64': {'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'other_nol64': {'tests': ['a11yr', 01:38:42 INFO - 'ts_paint', 01:38:42 INFO - 'tpaint', 01:38:42 INFO - 'sessionrestore', 01:38:42 INFO - 'sessionrestore_no_auto_restore', 01:38:42 INFO - 'tabpaint']}, 01:38:42 INFO - 'svgr': {'tests': ['tsvgx', 01:38:42 INFO - 'tsvgr_opacity', 01:38:42 INFO - 'tart', 01:38:42 INFO - 'tscrollx', 01:38:42 INFO - 'cart']}, 01:38:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['tsvgx', 01:38:42 INFO - 'tsvgr_opacity', 01:38:42 INFO - 'tart', 01:38:42 INFO - 'tscrollx', 01:38:42 INFO - 'cart']}, 01:38:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'tests': ['tp5o']}, 01:38:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'talos_options': ['--e10s'], 01:38:42 INFO - 'tests': ['tp5o']}, 01:38:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'talos_options': ['--xperf_path', 01:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:42 INFO - 'tests': ['tp5n']}, 01:38:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:38:42 INFO - 'talos_options': ['--e10s', 01:38:42 INFO - '--xperf_path', 01:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:42 INFO - 'tests': ['tp5n']}}, 01:38:42 INFO - 'talos.zip': {'path': '', 01:38:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:38:42 INFO - Running post-action listener: _resource_record_post_action 01:38:42 INFO - ##### 01:38:42 INFO - ##### Running create-virtualenv step. 01:38:42 INFO - ##### 01:38:42 INFO - Running pre-action listener: _resource_record_pre_action 01:38:42 INFO - Running main action method: create_virtualenv 01:38:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:38:42 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 01:38:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:38:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:38:42 INFO - Using real prefix '/usr' 01:38:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 01:38:45 INFO - Installing pip.................done. 01:38:45 INFO - Return code: 0 01:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:45 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:45 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 01:38:45 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 01:38:45 INFO - Using env: {'DISPLAY': ':0', 01:38:45 INFO - 'HOME': '/home/cltbld', 01:38:45 INFO - 'LANG': 'en_US.UTF-8', 01:38:45 INFO - 'LANGUAGE': 'en_US:en', 01:38:45 INFO - 'LOGNAME': 'cltbld', 01:38:45 INFO - 'MAIL': '/var/mail/cltbld', 01:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:45 INFO - 'MOZ_NO_REMOTE': '1', 01:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:45 INFO - 'NO_EM_RESTART': '1', 01:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:45 INFO - 'SHELL': '/bin/bash', 01:38:45 INFO - 'SHLVL': '1', 01:38:45 INFO - 'TERM': 'linux', 01:38:45 INFO - 'TMOUT': '86400', 01:38:45 INFO - 'USER': 'cltbld', 01:38:45 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:45 INFO - '_': '/tools/buildbot/bin/python'} 01:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:45 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 01:38:45 INFO - Cleaning up... 01:38:45 INFO - Return code: 0 01:38:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:45 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:45 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 01:38:45 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 01:38:45 INFO - Using env: {'DISPLAY': ':0', 01:38:45 INFO - 'HOME': '/home/cltbld', 01:38:45 INFO - 'LANG': 'en_US.UTF-8', 01:38:45 INFO - 'LANGUAGE': 'en_US:en', 01:38:45 INFO - 'LOGNAME': 'cltbld', 01:38:45 INFO - 'MAIL': '/var/mail/cltbld', 01:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:45 INFO - 'MOZ_NO_REMOTE': '1', 01:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:45 INFO - 'NO_EM_RESTART': '1', 01:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:45 INFO - 'SHELL': '/bin/bash', 01:38:45 INFO - 'SHLVL': '1', 01:38:45 INFO - 'TERM': 'linux', 01:38:45 INFO - 'TMOUT': '86400', 01:38:45 INFO - 'USER': 'cltbld', 01:38:45 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:45 INFO - '_': '/tools/buildbot/bin/python'} 01:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:45 INFO - Downloading/unpacking psutil>=0.7.1 01:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:38:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:47 INFO - Installing collected packages: psutil 01:38:47 INFO - Running setup.py install for psutil 01:38:47 INFO - building 'psutil._psutil_linux' extension 01:38:47 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 01:38:48 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 01:38:48 INFO - building 'psutil._psutil_posix' extension 01:38:48 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 01:38:48 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 01:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:48 INFO - Successfully installed psutil 01:38:48 INFO - Cleaning up... 01:38:48 INFO - Return code: 0 01:38:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:38:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:38:48 INFO - Using env: {'DISPLAY': ':0', 01:38:48 INFO - 'HOME': '/home/cltbld', 01:38:48 INFO - 'LANG': 'en_US.UTF-8', 01:38:48 INFO - 'LANGUAGE': 'en_US:en', 01:38:48 INFO - 'LOGNAME': 'cltbld', 01:38:48 INFO - 'MAIL': '/var/mail/cltbld', 01:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:48 INFO - 'MOZ_NO_REMOTE': '1', 01:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:48 INFO - 'NO_EM_RESTART': '1', 01:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:48 INFO - 'SHELL': '/bin/bash', 01:38:48 INFO - 'SHLVL': '1', 01:38:48 INFO - 'TERM': 'linux', 01:38:48 INFO - 'TMOUT': '86400', 01:38:48 INFO - 'USER': 'cltbld', 01:38:48 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:48 INFO - '_': '/tools/buildbot/bin/python'} 01:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:38:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:38:50 INFO - Installing collected packages: mozsystemmonitor 01:38:50 INFO - Running setup.py install for mozsystemmonitor 01:38:50 INFO - Successfully installed mozsystemmonitor 01:38:50 INFO - Cleaning up... 01:38:50 INFO - Return code: 0 01:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:38: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')]} 01:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:50 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:50 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 01:38:50 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 01:38:50 INFO - Using env: {'DISPLAY': ':0', 01:38:50 INFO - 'HOME': '/home/cltbld', 01:38:50 INFO - 'LANG': 'en_US.UTF-8', 01:38:50 INFO - 'LANGUAGE': 'en_US:en', 01:38:50 INFO - 'LOGNAME': 'cltbld', 01:38:50 INFO - 'MAIL': '/var/mail/cltbld', 01:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:50 INFO - 'MOZ_NO_REMOTE': '1', 01:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:50 INFO - 'NO_EM_RESTART': '1', 01:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:50 INFO - 'SHELL': '/bin/bash', 01:38:50 INFO - 'SHLVL': '1', 01:38:50 INFO - 'TERM': 'linux', 01:38:50 INFO - 'TMOUT': '86400', 01:38:50 INFO - 'USER': 'cltbld', 01:38:50 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:50 INFO - '_': '/tools/buildbot/bin/python'} 01:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:38:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:38:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:38:52 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 01:38:52 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 01:38:52 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 01:38:52 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 01:38:52 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 01:38:52 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 01:38:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:38:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:53 INFO - Downloading docopt-0.6.1.tar.gz 01:38:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:38:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:38:53 INFO - Running setup.py install for blobuploader 01:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:38:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:38:53 INFO - Running setup.py install for requests 01:38:53 INFO - Running setup.py install for docopt 01:38:53 INFO - Successfully installed blobuploader requests docopt 01:38:53 INFO - Cleaning up... 01:38:53 INFO - Return code: 0 01:38:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:38: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')]} 01:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:54 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:54 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 01:38:54 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 01:38:54 INFO - Using env: {'DISPLAY': ':0', 01:38:54 INFO - 'HOME': '/home/cltbld', 01:38:54 INFO - 'LANG': 'en_US.UTF-8', 01:38:54 INFO - 'LANGUAGE': 'en_US:en', 01:38:54 INFO - 'LOGNAME': 'cltbld', 01:38:54 INFO - 'MAIL': '/var/mail/cltbld', 01:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:54 INFO - 'MOZ_NO_REMOTE': '1', 01:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:54 INFO - 'NO_EM_RESTART': '1', 01:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:54 INFO - 'SHELL': '/bin/bash', 01:38:54 INFO - 'SHLVL': '1', 01:38:54 INFO - 'TERM': 'linux', 01:38:54 INFO - 'TMOUT': '86400', 01:38:54 INFO - 'USER': 'cltbld', 01:38:54 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:54 INFO - '_': '/tools/buildbot/bin/python'} 01:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:38:54 INFO - Running setup.py (path:/tmp/pip-M6w_fS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:38:54 INFO - Running setup.py (path:/tmp/pip-OraNgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:38:54 INFO - Running setup.py (path:/tmp/pip-z12n3z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:38:54 INFO - Running setup.py (path:/tmp/pip-JScZx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:38:54 INFO - Running setup.py (path:/tmp/pip-rPR96T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:38:54 INFO - Running setup.py (path:/tmp/pip-m3XLgV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:38:54 INFO - Running setup.py (path:/tmp/pip-NbALmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:38:54 INFO - Running setup.py (path:/tmp/pip-L4slyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:38:54 INFO - Running setup.py (path:/tmp/pip-Umj37Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:38:54 INFO - Running setup.py (path:/tmp/pip-6lZsD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:38:54 INFO - Running setup.py (path:/tmp/pip-a52GXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:38:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:38:55 INFO - Running setup.py (path:/tmp/pip-poksSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:38:55 INFO - Running setup.py (path:/tmp/pip-iMygWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:38:55 INFO - Running setup.py (path:/tmp/pip-ii8qBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:38:55 INFO - Running setup.py (path:/tmp/pip-CGcHxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:38:55 INFO - Running setup.py (path:/tmp/pip-AzX1hv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:38:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:38:55 INFO - Running setup.py (path:/tmp/pip-CoEirc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:55 INFO - Running setup.py install for manifestparser 01:38:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:38:55 INFO - Running setup.py install for mozcrash 01:38:55 INFO - Running setup.py install for mozdebug 01:38:55 INFO - Running setup.py install for mozdevice 01:38:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:38:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:38:55 INFO - Running setup.py install for mozfile 01:38:55 INFO - Running setup.py install for mozhttpd 01:38:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozinfo 01:38:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozInstall 01:38:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozleak 01:38:56 INFO - Running setup.py install for mozlog 01:38:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for moznetwork 01:38:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozprocess 01:38:56 INFO - Running setup.py install for mozprofile 01:38:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozrunner 01:38:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:38:56 INFO - Running setup.py install for mozscreenshot 01:38:56 INFO - Running setup.py install for moztest 01:38:57 INFO - Running setup.py install for mozversion 01:38:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:38:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:57 INFO - Cleaning up... 01:38:57 INFO - Return code: 0 01:38:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:57 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:38:57 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 01:38:57 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 01:38:57 INFO - Using env: {'DISPLAY': ':0', 01:38:57 INFO - 'HOME': '/home/cltbld', 01:38:57 INFO - 'LANG': 'en_US.UTF-8', 01:38:57 INFO - 'LANGUAGE': 'en_US:en', 01:38:57 INFO - 'LOGNAME': 'cltbld', 01:38:57 INFO - 'MAIL': '/var/mail/cltbld', 01:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:57 INFO - 'MOZ_NO_REMOTE': '1', 01:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:57 INFO - 'NO_EM_RESTART': '1', 01:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:38:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:38:57 INFO - 'SHELL': '/bin/bash', 01:38:57 INFO - 'SHLVL': '1', 01:38:57 INFO - 'TERM': 'linux', 01:38:57 INFO - 'TMOUT': '86400', 01:38:57 INFO - 'USER': 'cltbld', 01:38:57 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:57 INFO - '_': '/tools/buildbot/bin/python'} 01:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:38:57 INFO - Running setup.py (path:/tmp/pip-tT11nH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:38:57 INFO - Running setup.py (path:/tmp/pip-4KBqqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:38:57 INFO - Running setup.py (path:/tmp/pip-75x0hQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:38:57 INFO - Running setup.py (path:/tmp/pip-gA8CeZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:38:57 INFO - Running setup.py (path:/tmp/pip-Gqr5Is-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:38:57 INFO - Running setup.py (path:/tmp/pip-4F9HJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:38:57 INFO - Running setup.py (path:/tmp/pip-QgmDKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:38:57 INFO - Running setup.py (path:/tmp/pip-11COdp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:38:57 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)) 01:38:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:38:58 INFO - Running setup.py (path:/tmp/pip-pe7WBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:38:58 INFO - Running setup.py (path:/tmp/pip-gZQbSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:38:58 INFO - Running setup.py (path:/tmp/pip-Q8zZHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:38:58 INFO - Running setup.py (path:/tmp/pip-S7i8uy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:38:58 INFO - Running setup.py (path:/tmp/pip-jnuq5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:38:58 INFO - Running setup.py (path:/tmp/pip-7d7GE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:38:58 INFO - Running setup.py (path:/tmp/pip-ypXLG4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:38:58 INFO - Running setup.py (path:/tmp/pip-GGAf7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:38:58 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)) 01:38:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:38:58 INFO - Running setup.py (path:/tmp/pip-TNS5gK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:38:58 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)) 01:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:58 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)) 01:38:58 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)) 01:38:58 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)) 01:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:58 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 01:38:58 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 01:38:58 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 01:38:58 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 01:38:58 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 01:38:58 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 01:39:00 INFO - Downloading blessings-1.6.tar.gz 01:39:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:39:00 INFO - Installing collected packages: blessings 01:39:00 INFO - Running setup.py install for blessings 01:39:00 INFO - Successfully installed blessings 01:39:00 INFO - Cleaning up... 01:39:00 INFO - Return code: 0 01:39:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:39:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:39:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:39:00 INFO - Reading from file tmpfile_stdout 01:39:00 INFO - Current package versions: 01:39:00 INFO - argparse == 1.2.1 01:39:00 INFO - blessings == 1.6 01:39:00 INFO - blobuploader == 1.2.4 01:39:00 INFO - docopt == 0.6.1 01:39:00 INFO - manifestparser == 1.1 01:39:00 INFO - mozInstall == 1.12 01:39:00 INFO - mozcrash == 0.17 01:39:00 INFO - mozdebug == 0.1 01:39:00 INFO - mozdevice == 0.48 01:39:00 INFO - mozfile == 1.2 01:39:00 INFO - mozhttpd == 0.7 01:39:00 INFO - mozinfo == 0.9 01:39:00 INFO - mozleak == 0.1 01:39:00 INFO - mozlog == 3.1 01:39:00 INFO - moznetwork == 0.27 01:39:00 INFO - mozprocess == 0.22 01:39:00 INFO - mozprofile == 0.28 01:39:00 INFO - mozrunner == 6.11 01:39:00 INFO - mozscreenshot == 0.1 01:39:00 INFO - mozsystemmonitor == 0.0 01:39:00 INFO - moztest == 0.7 01:39:00 INFO - mozversion == 1.4 01:39:00 INFO - psutil == 3.1.1 01:39:00 INFO - requests == 1.2.3 01:39:00 INFO - wsgiref == 0.1.2 01:39:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:39:00 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')]} 01:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 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')]} 01:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:39:00 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 01:39:01 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 01:39:01 INFO - Using env: {'DISPLAY': ':0', 01:39:01 INFO - 'HOME': '/home/cltbld', 01:39:01 INFO - 'LANG': 'en_US.UTF-8', 01:39:01 INFO - 'LANGUAGE': 'en_US:en', 01:39:01 INFO - 'LOGNAME': 'cltbld', 01:39:01 INFO - 'MAIL': '/var/mail/cltbld', 01:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:01 INFO - 'MOZ_NO_REMOTE': '1', 01:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:01 INFO - 'NO_EM_RESTART': '1', 01:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:39:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:39:01 INFO - 'SHELL': '/bin/bash', 01:39:01 INFO - 'SHLVL': '1', 01:39:01 INFO - 'TERM': 'linux', 01:39:01 INFO - 'TMOUT': '86400', 01:39:01 INFO - 'USER': 'cltbld', 01:39:01 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:01 INFO - '_': '/tools/buildbot/bin/python'} 01:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 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)) 01:39:01 INFO - Cleaning up... 01:39:01 INFO - Return code: 0 01:39:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:01 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:39:01 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 01:39:01 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 01:39:01 INFO - Using env: {'DISPLAY': ':0', 01:39:01 INFO - 'HOME': '/home/cltbld', 01:39:01 INFO - 'LANG': 'en_US.UTF-8', 01:39:01 INFO - 'LANGUAGE': 'en_US:en', 01:39:01 INFO - 'LOGNAME': 'cltbld', 01:39:01 INFO - 'MAIL': '/var/mail/cltbld', 01:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:01 INFO - 'MOZ_NO_REMOTE': '1', 01:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:01 INFO - 'NO_EM_RESTART': '1', 01:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:39:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:39:01 INFO - 'SHELL': '/bin/bash', 01:39:01 INFO - 'SHLVL': '1', 01:39:01 INFO - 'TERM': 'linux', 01:39:01 INFO - 'TMOUT': '86400', 01:39:01 INFO - 'USER': 'cltbld', 01:39:01 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:01 INFO - '_': '/tools/buildbot/bin/python'} 01:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:01 INFO - Downloading/unpacking jsonschema 01:39:01 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 01:39:01 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 01:39:01 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 01:39:01 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 01:39:01 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 01:39:01 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 01:39:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:39:03 INFO - Downloading/unpacking functools32 (from jsonschema) 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:39:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:39:03 INFO - warning: no files found matching '*.txt' 01:39:03 INFO - no previously-included directories found matching 'build' 01:39:03 INFO - no previously-included directories found matching 'dist' 01:39:03 INFO - no previously-included directories found matching '.git*' 01:39:03 INFO - Installing collected packages: jsonschema, functools32 01:39:03 INFO - Running setup.py install for functools32 01:39:03 INFO - warning: no files found matching '*.txt' 01:39:03 INFO - no previously-included directories found matching 'build' 01:39:03 INFO - no previously-included directories found matching 'dist' 01:39:03 INFO - no previously-included directories found matching '.git*' 01:39:03 INFO - Successfully installed jsonschema functools32 01:39:03 INFO - Cleaning up... 01:39:03 INFO - Return code: 0 01:39:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:39:03 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')]} 01:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:03 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')]} 01:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:03 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 0x7fdd44f51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cb6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, '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': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', '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 01:39:03 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 01:39:03 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 01:39:03 INFO - Using env: {'DISPLAY': ':0', 01:39:03 INFO - 'HOME': '/home/cltbld', 01:39:03 INFO - 'LANG': 'en_US.UTF-8', 01:39:03 INFO - 'LANGUAGE': 'en_US:en', 01:39:03 INFO - 'LOGNAME': 'cltbld', 01:39:03 INFO - 'MAIL': '/var/mail/cltbld', 01:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:03 INFO - 'MOZ_NO_REMOTE': '1', 01:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:03 INFO - 'NO_EM_RESTART': '1', 01:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:39:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:39:03 INFO - 'SHELL': '/bin/bash', 01:39:03 INFO - 'SHLVL': '1', 01:39:03 INFO - 'TERM': 'linux', 01:39:03 INFO - 'TMOUT': '86400', 01:39:03 INFO - 'USER': 'cltbld', 01:39:03 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:03 INFO - '_': '/tools/buildbot/bin/python'} 01:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:03 INFO - Downloading/unpacking flake8 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:03 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 01:39:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:39:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:39:05 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 01:39:05 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 01:39:05 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 01:39:05 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 01:39:05 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 01:39:05 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 01:39:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:39:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:39: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 01:39: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 01:39: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 01:39: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 01:39: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 01:39: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 01:39:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:39: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 01:39: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 01:39: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 01:39: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 01:39: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 01:39: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 01:39:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:39:06 INFO - no previously-included directories found matching 'docs/_build' 01:39:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:39:06 INFO - Running setup.py install for pep8 01:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:39:06 INFO - no previously-included directories found matching 'docs/_build' 01:39:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:39:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:39:06 INFO - Cleaning up... 01:39:06 INFO - Return code: 0 01:39:06 INFO - Running post-action listener: _resource_record_post_action 01:39:06 INFO - Running post-action listener: _start_resource_monitoring 01:39:06 INFO - Starting resource monitoring. 01:39:06 INFO - ##### 01:39:06 INFO - ##### Running install step. 01:39:06 INFO - ##### 01:39:06 INFO - Running pre-action listener: _resource_record_pre_action 01:39:06 INFO - Running main action method: install 01:39:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:39:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:39:07 INFO - Reading from file tmpfile_stdout 01:39:07 INFO - Detecting whether we're running mozinstall >=1.0... 01:39:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:39:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:39:07 INFO - Reading from file tmpfile_stdout 01:39:07 INFO - Output received: 01:39:07 INFO - Usage: mozinstall [options] installer 01:39:07 INFO - Options: 01:39:07 INFO - -h, --help show this help message and exit 01:39:07 INFO - -d DEST, --destination=DEST 01:39:07 INFO - Directory to install application into. [default: 01:39:07 INFO - "/builds/slave/test-pgo"] 01:39:07 INFO - --app=APP Application being installed. [default: firefox] 01:39:07 INFO - mkdir: /builds/slave/test-pgo/build/application 01:39:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:39:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:39:23 INFO - Reading from file tmpfile_stdout 01:39:23 INFO - Output received: 01:39:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:39:23 INFO - Running post-action listener: _resource_record_post_action 01:39:23 INFO - ##### 01:39:23 INFO - ##### Running run-tests step. 01:39:23 INFO - ##### 01:39:23 INFO - Running pre-action listener: _resource_record_pre_action 01:39:23 INFO - Running main action method: run_tests 01:39:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:39:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:39:23 INFO - Python 2.7.3 01:39:23 INFO - Return code: 0 01:39:23 INFO - grabbing minidump binary from tooltool 01:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:39:23 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 0x12c61d0>, '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 0x12c9750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12c9be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:39:23 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 01:39:23 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 01:39:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:39:23 INFO - Return code: 0 01:39:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:39:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:39:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:39:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:39:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:39:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:39:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:39:24 INFO - Return code: 0 01:39:24 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/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 01:39:24 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/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 01:39:24 INFO - Using env: {'DISPLAY': ':0', 01:39:24 INFO - 'HOME': '/home/cltbld', 01:39:24 INFO - 'LANG': 'en_US.UTF-8', 01:39:24 INFO - 'LANGUAGE': 'en_US:en', 01:39:24 INFO - 'LOGNAME': 'cltbld', 01:39:24 INFO - 'MAIL': '/var/mail/cltbld', 01:39:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:39:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:24 INFO - 'MOZ_NO_REMOTE': '1', 01:39:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:24 INFO - 'NO_EM_RESTART': '1', 01:39:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:39:24 INFO - 'PWD': '/builds/slave/test-pgo', 01:39:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:39:24 INFO - 'SHELL': '/bin/bash', 01:39:24 INFO - 'SHLVL': '1', 01:39:24 INFO - 'TERM': 'linux', 01:39:24 INFO - 'TMOUT': '86400', 01:39:24 INFO - 'USER': 'cltbld', 01:39:24 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458289000.974407-355351161', 01:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:24 INFO - '_': '/tools/buildbot/bin/python'} 01:39:24 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/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 01:39:25 INFO - mozversion application_buildid: 20160317203056 01:39:25 INFO - mozversion application_changeset: d9cc905f0f37faa8d1da6e449709d261eda4933b 01:39:25 INFO - mozversion application_display_name: Nightly 01:39:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:39:25 INFO - mozversion application_name: Firefox 01:39:25 INFO - mozversion application_remotingname: firefox 01:39:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:39:25 INFO - mozversion application_vendor: Mozilla 01:39:25 INFO - mozversion application_version: 48.0a1 01:39:25 INFO - mozversion platform_buildid: 20160317203056 01:39:25 INFO - mozversion platform_changeset: d9cc905f0f37faa8d1da6e449709d261eda4933b 01:39:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:39:25 INFO - mozversion platform_version: 48.0a1 01:39:25 INFO - using testdate: 1458290365 01:39:25 INFO - actual date: 1458290365 01:39:25 INFO - starting webserver on 'localhost:37499' 01:39:25 INFO - SUITE-START | Running 2 tests 01:39:25 INFO - TEST-START | dromaeo_css 01:39:25 INFO - operating with platform_type : linux_ 01:39:25 INFO - Initialising browser for dromaeo_css test... 01:39:25 INFO - TEST-INFO | started process 300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_cayPy/profile http://localhost:37499/getInfo.html) 01:39:29 INFO - PROCESS | 300 | __metrics Screen width/height:1600/1200 01:39:29 INFO - PROCESS | 300 | colorDepth:24 01:39:29 INFO - PROCESS | 300 | Browser inner width/height: 1024/697 01:39:29 INFO - PROCESS | 300 | __metrics 01:39:30 ERROR - PROCESS | 300 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:39:31 INFO - TEST-INFO | 300: exit 0 01:39:31 INFO - Browser initialized. 01:39:31 INFO - Running cycle 1/1 for dromaeo_css test... 01:39:31 INFO - TEST-INFO | started process 394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_cayPy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:43 INFO - PROCESS | 394 | RSS: Main: 152244224 01:39:43 INFO - PROCESS | 394 | 01:40:34 INFO - PROCESS | 394 | 1458290434085 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] 01:42:41 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37499/tests/dromaeo/cssquery-ext.html) 01:42:42 INFO - PROCESS | 394 | RSS: Main: 254533632 01:42:42 INFO - PROCESS | 394 | 01:45:44 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-ext.html (next: http://localhost:37499/tests/dromaeo/cssquery-jquery.html) 01:45:45 INFO - PROCESS | 394 | RSS: Main: 230506496 01:45:45 INFO - PROCESS | 394 | 01:48:47 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37499/tests/dromaeo/cssquery-mootools.html) 01:48:47 INFO - PROCESS | 394 | RSS: Main: 236646400 01:48:47 INFO - PROCESS | 394 | 01:51:49 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37499/tests/dromaeo/cssquery-prototype.html) 01:51:50 INFO - PROCESS | 394 | RSS: Main: 215871488 01:51:50 INFO - PROCESS | 394 | 01:54:52 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37499/tests/dromaeo/cssquery-yui.html) 01:54:53 INFO - PROCESS | 394 | RSS: Main: 214536192 01:54:53 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | Cycle 1(1): loaded http://localhost:37499/tests/dromaeo/cssquery-yui.html (next: http://localhost:37499/tests/dromaeo/cssquery-dojo.html) 01:57:55 INFO - PROCESS | 394 | RSS: Main: 286126080 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | __start_tp_report 01:57:55 INFO - PROCESS | 394 | _x_x_mozilla_page_load 01:57:55 INFO - PROCESS | 394 | _x_x_mozilla_page_load_details 01:57:55 INFO - PROCESS | 394 | |i|pagename|runs| 01:57:55 INFO - PROCESS | 394 | |0;dojo.html;2961.6890226526216;2994.775391845612;3019.939601207976;3032.3632037272173;3063.571100045994;4999.050180465718;5193.792248310063;5218.243354713569;5228.816991405297;5262.81580144695;5259.526642602165;5269.736513174345;5299.390570084442;5311.362636483617;5342.011727830344;4707.576318131368;4715.57559819617;4724.574788269055;4726.456457507379;4842.806287748504;4780.3307536944685;4780.5936495397755;4808.086463571927;4829.637777166709;4885.022995400916;4673.742944138071;4673.953260467403;4733.455652599961;4740.241561350202;4759.7382143981895;4678.649101317381;4695.929561056587;4696.436427628706;4717.504662010508;4739.312799644067;4598.149342371638;4675.2052151134385;4688.390509233812;4721.102990431807;4742.027884283748;5095.643304968654;5101.234814777776;5112.846614601568;5114.897702045975;5148.613853960968;5501.5323697485765;5509.449055094498;5509.807156749494;5510.8071217507595;5557.3886872444;5481.698506582136;5548.69482178484;5583.972080139614;5636.802711905064;5696.316442026983;5262.447443018466;5273.34083239595;5277.525022747933;5282.683039017671;5293.311869456985;5757.107648314518;5777.88444231113;5778.3354914184565;5779.335376431764;5785.739641716133;5376.059189641797;5453.700046497402;5507.228987941691;5534.252875861787;5559.8888022239325;5512.751926163332;5522.723863806794;5524.226608274845;5531.723413829292;5532.97639936605;5507.642003269774;5508.586855985817;5510.8071217507195;5511.421300763443;5554.416786237468;5375.139977603565;5503.477169668875;5560.638558493685;5567.526760225426;5603;4257.212415703105;4287.142571485715;4287.914241715148;4292.163028209469;4329.393884856123;3669.3578623740736;3823.292690852146;3826.0626146594263;3839.404892241707;3879.4956655634587;5169.638125331266;5194.506521880416;5219.5041471060185;5258.2638430619745;5272.077386457355;5600.271964644651;5664.0937450007805;5666.9716651416475;5668.404817494104;5669.858253543694;5130.204818253177;5197.58419326453;5278;5352.223927530564;5394.73026348681;4618.815247390066;4633.2818413146015;4637.397138372057;4651.069786042805;4677.064587082597;5718.428157184331;5721.685307308138;5726.799562015392;5726.856828579235;5776.7111644418455;5384.865378365572;5531.695756733257;5533.418991005967;5534.225208470737;5629.943700563106;5821.330546986981;5826.980278451339;5839.678817665069;5860.794872179454;5894.941050589439;5506.1190209566275;5532.695701736443;5537;5542.168674698827;5548.778048878;5490.91763623538;5520.282363292747;5578.386377498553;5605.159226116115;5606.635568688022;5437.537809286255;5441.673499590037;5445.972770136124;5455.890882182255;5497.47773961473;5390.676559406448;5419.783208671609;5431.293931788842;5434.782608695607;5486.094794359045;5163.3545806774155;5273.551748101454;5325.201219817059;5387.111126664056;5441.673499590037;5517.61376703643;5537.086380747131;5539.279893613804;5552.416996215339;5559.11054231321;5379;5438.646487978269;5438.728063596884;5440.292761940922;5490.560755139659 01:57:55 INFO - PROCESS | 394 | |1;ext.html;555.7582451633542;582.350678992923;611.0864257934387;626.1234272019173;637.8756142552203;33117.50323745143;38406;38839.80580097103;38894.41658375126;38959.61040389599;44344.77827610866;45316.0936781265;45397.54602453975;45443.54556454434;45493.090138197214;7829.138794732575;7960.323372513343;7971.561564113971;8723.171298726611;8977.371583989123;10310.7422314442;10572.365658060502;10575.365478071302;10582;10586.947065264663;10342;10425.843612345821;10436.425996570186;10441.42572158531;10444.164466842634;10203.234757393226;10286.485675716222;10291.33106348085;10292.639757608522;10293.53679084443;10280.228982826244;10438.63464778729;10452.79094418115;10463.162946964301;10470.79058418835;41454.37818432726;41514;41569.58430415718;41588.37617435741;41606.1678766426;3409.539712138879;3880.844766209348;4162.084341444877;4165.12532368203;4287.957120428819;31988.840055799807;32417.837910810296;32497.51253731196;32673;32975.50536741951;3840.9039774005873;3920.1289842490387;3967.7222594418404;3971.9007024824323;4149.294619914622;312082;314431;314673;315036;315239;46149.30776038362;46162.076758464646;61758.69120654368;62163.37836621666;62229;43716.12567748627;44242;44314;44444.333335;44566.331505027454;15895.443659471863;15985.12081835487;16020.919895400448;16056.839431605767;16064.27710753019;12752.107352485236;12857.292848893214;12859.549915752903;12860.807087893689;12862.678433039062;15566.922165389327;15596.532104036896;15597.922010389875;15610.3755849767;15615.921920390552;5901.793437229762;6087.208662873798;6147.508199344042;6148.8770224595255;6214.564980451325;1017.6539976408056;1099.9010089092021;1155.3760969076604;1159.6405114414558;1167.8656954450346;31411.214719631735;32139;32171.839140804615;32678.18304542358;32681.673183267863;1196.1567095197865;1198.9820152697716;1234.2779474007627;1237.0227520259075;1258.4966013594635;16394.590135246715;16710.58223544421;16720.58198545022;16737.581560460843;16958.915205423895;386792;388163;389752;390606.46967652073;390874;55766;56220;56227.71886140543;56282;56286;1196.5154112584416;1365.0512893538896;1386.7850483175123;1399.0067052392915;1428.992855035718;27562.310942225802;29055;29128;29417.264568385963;29706;42652.78673606612;53526.197107042644;54063;54143.729281354914;54265.45734542604;284200;285425;286292;287047;288558;37582.2483550322;44485.33272000858;45202;45556.544434556556;45567.31649025201;43237.78381108074;44199.558004419545;44223.77888110539;47148.29277560908;47314.52685473239;37240.44139337966;39246.4113038299;39573.20853582855;39820.80089599534;39989.40015899706;37486.812565937;37861.621383786915;38578;39613.40579891361;39731.205375892896;40297;40833;41008.17983640251;41123;41168.38247426231;31562;32156.356872862878;32389.514157287187;32429.837850810596;32688.673113269513;27525.724742752314;27603;27725.445491090468;27927.720722792514;27967.860160699067 01:57:55 INFO - PROCESS | 394 | |2;jquery.html;328.4498465071006;329.8927848449255;340.2752137946174;345.2353038020784;347.3019231344996;17358.392456264035;17983.73024404633;18035.909820450895;19182.90408547959;19212.327568535104;17327.30690772371;17723.91138044311;17989.64020719588;18076.819231807676;18089;5166.741662916848;5169.612279079065;5386.78452861885;5387.19192121181;5389.434109418514;3946.6842652587866;5323.840284791462;5369.731513424333;5564.972175139119;5790.623609465392;5724.91226666934;5801.245838041049;5803.303603567578;5803.680797556132;5807.941920580783;5612.915806262909;5687.886242275152;5715.028445164311;5762.625429347079;5763.366029736726;3547.4324108142832;4913.901721965576;5046.343975283226;5052.393712754456;5114.386273647149;20200;20536.17855285787;20539.691904621443;20826.47933801652;20851.478713032146;2130.5632345369163;2282.2468585366787;2307.619242824932;2506.962395564068;2528.645989561463;9086.409383390059;9126.17864392208;9134.680286190018;12153.630042141785;13681.452741890313;1979.4952287166825;1984.2360691133872;2027.1688607670785;2109.5253567947243;2149.570085982794;68415.31584684139;70819.29180708178;70896;71063.28936710619;71266;10116.595336186618;10122.493875306205;10129.088382045504;10135.594576217016;10243.38539687621;12631.305278209788;12726.872731272753;12737.490500380067;12739.36303184837;12758.106932514635;7814.233243769544;8032.277095061472;8060.959695201486;8080.515169089874;8158.184181581794;8181.959090204511;8245.093039765621;8267;8348.165183481724;8387.245147936716;4213.6207741302815;4236.131593023423;4268.125034367947;4268.615824575803;4314.80583373749;1616.3049888547803;1673.4979506148106;1688.1981058996878;1744.0582085673848;1748.1783561725968;1001.998001998002;1031.8091153136693;1055.1400608504198;1056.9852941176557;1067.6209945469402;16964.830351696324;17832.643347132984;17841.910790445963;18101.818981810276;18413.90793046053;965.1217392173089;981.6220755009373;1000.9040101089296;1024.4263212600968;1070.1385384765183;9875.160611347972;9903.554340054714;10276.794464110826;10303.896961030443;10353.171746260281;449529;452381;505130;507710;512995;72391.63804180945;75322;79144;79344.60327698325;85692.57153714192;1061.7186445591924;1089.5042755546208;1109.6837401340579;1110.8444817725524;1111.6276047524009;16450.75323870119;16520.173991300147;16652.666946660756;16680.916595416944;16776.412825551048;34758.30483390368;35772;36791.81604091962;36893;37365.4395184067;49973.50026499688;53572.732136339066;53843.46156538385;53921.460785391646;53982.730086349315;7394.964704941205;7416.517926334771;7569.583672897823;7575.772726818204;7635.656395462106;8424.073351931405;11852.585159519376;12268;12523.686907827378;12589.118761686594;10379;10477.16182705397;10669.253152279576;10725.08836748885;10792.622258220925;10696.893031069902;10778.407187604756;10942.507587158438;11164.330140191614;11329.603463879055;10513.211509136998;10772.24594278393;10994.450277485934;11137.721556961142;11241.71895702614;7320.597367144858;7324.487285889936;7358.411327093927;7440.4419668524;7550.244975502405;10957.780844383227;10995.395253261147;11121.666350009513;11123.499442524944;11161.665150045512 01:57:55 INFO - PROCESS | 394 | |3;mootools.html;1358.714669919317;1499.1979291079274;1500.3998400639744;1672.682190383827;1789.9642007159848;7530.849383012336;7685.807854803633;7686.385089192865;7690.423218258632;7695.422843286755;7634.274743899321;7683.500572462786;7772.494787838787;7774.727884524043;7798.376129909608;1975.2395327798756;2018.6265540874986;2211.203966572041;2302.9654555181687;2327.499587588668;2274.3404412720374;2279.031411650042;2282.4522114692522;2283.8058765004994;2286.371247906822;2183.465051062492;2212.7676593957644;2258.6047441697638;2258.706368172135;2260.4461906832767;2212.811910987552;2236.7427745809277;2244.629636110048;2250.189931624614;2294.8393612447135;2244.079927229844;2253.966190507144;2263.46808500004;2265.67147763575;2272.2388000019846;7864.410169237273;7903.960480197562;7930.524168549906;7943.205679432069;7948.046234451903;4700.29495575663;4796.856094317176;4799.0401919616215;4804.8318308859025;4806.711597304173;3053.6793636668053;3086.7067628575473;3122.406742718876;3152.8896488622786;3158.2735970726862;996.1084829078007;1003.6687892995294;1019.7195771162916;1022.2026819081128;1040.0223789637791;10626.681199563947;10713.946430267877;10794.460276986198;10806;10809.243352965295;3969.206158768258;4099.385092236188;4111.403846442309;4160.791960401968;4176.540580536139;8692;8739;8833.29333653319;8837.513936733412;8911.465312081296;4801.087793319258;4818.807247710122;4834.8791280218275;4835.202191638411;4835.44392394872;3838.251540949544;4310.331898555729;4374.234508960983;4377.868663940087;4391.890202744957;3533.7526373154146;3615.5661320641693;3647.9635203648154;3656.2321912398693;3658.1951970566433;1086.6305456144948;1101.9669409917715;1106.1703722208345;1122.5678113926197;1126.971825704364;1241.2366394667215;1266.379474057705;1268.8921441677376;1404.45226361719;1422.8363738170242;7519.436042296849;7609.201033891472;7718.652660630285;7733.304002639789;7734.651940662684;469.36869909971034;473.2687997044574;474.42831388177166;477.2650118817052;477.8351468743278;5832.825015249549;5855.560832937462;5889.617174883704;5938.703064846741;5944.375840536768;9187.127222913812;9803.921568627446;9805.117539421486;9809.558569864374;9951.800963980824;9639.951800241095;9648.71053868385;9709.9029009709;9743.756406089904;9769.267304952156;7305.269473052652;7500.474966752384;7515.060617422713;7586.924130758622;7598.696052157962;7266.854662906607;7349.228331025379;7354.963225184054;7368.484206105735;7391.556506609621;8587.484750914966;8664.046954835088;8670.479771213748;8780.165884241242;8824.161704638305;8177.550234736908;8968.10318968098;9066.86664166979;9119.407238529475;9135.451872887648;6099.237595300588;6224.719887605159;6654.633995130121;7017.719291228498;7119.75080872167;7432.739854105081;7467.663955121924;7473.51422157558;7490.363319117936;7512.361449276873;6685.164354455693;6868.896966545606;6889.276625954202;6995.685194166376;7065.046218760607;6879.727250458681;6912.79261622132;6974.860502790018;6999.545029573062;7000.439964802906;6930.203026652;6931.861362772817;7027.9297207027275;7118.181409138016;7169.426445884421;6615.040819081302;6623.205215373993;6656.966715166393;6671.733130674718;6672.099266599141;6517.217933847968;6712.39588437043;6733.865322693421;6748.291429400038;6749.831254218684 01:57:55 INFO - PROCESS | 394 | |4;prototype.html;303.2903006963704;305.9816411015341;313.70668425022603;316.51415077855495;321.74582080156677;5965.671888046156;6010.248718910137;6027.36712645172;6030.27636683598;6042.909356359658;5930.406959304068;5951.761929522825;5965.373635768236;5968.313643930949;5969.164316995624;4280.443542339499;4425.269830477967;4515.525869783674;4525.773711314438;4533.863984080483;4490.259107247317;4522.050369422425;4528.796204170803;4530;4530.682852200347;4306.504751953518;4479.4176757021705;4486.170058539181;4490.550944905516;4491.865244042668;4406.977965110186;4471.776411179428;4472.8881777955485;4477.888052798674;4484.282514797649;3889.124946886956;3896.3960586108915;3897.2205558888336;3902.3756199008308;3905.33609286422;5733.598648094635;5739.540836733093;5744.6840423776675;5744.741486633112;5755.136729490568;5169.638125331228;5178.300929374524;5179.04187725272;5180;5182.093133701587;6210.534209934228;6211;6222.875542489171;6224.968875155595;6231;4082.755034697898;4199.664026877843;4200.7479551227025;4213.641840443566;4287.742735435884;6515.4787616991;6550.820852246594;6565.048068030157;6581.769638062693;6582.670866456658;4321.481422229353;4321.913561728811;4325.870223893288;4327.285997810326;4327.82688692455;4358.56414358568;4375.474943006796;4380.912381752347;4382.671299652475;4383.868483945423;5120.155174396183;5121.847584293579;5122.052420302256;5125.666831655931;5130.4100028497205;6155.507559395238;6311.715972781236;6312.52656050798;6316.557840951089;6319.368063193736;1516.5147152910963;1516.9165695886832;1534.6547026918854;1536.377767004365;1538.4922975418085;947.3984020147118;990.2424645146468;992.4144754594823;1004.0060340263233;1017.9847302290472;6023.6385816851125;6027.638341699512;6061.121137435135;6076.817695469143;6077.9392206078255;6480.708368123445;6485.513586481033;6486.870262594722;6487.837804054936;6493.026046093124;6048.395160483917;6057.8485537861025;6059.454649081604;6064.545159112996;6068.848278793065;3450.447928331455;3451.6720911513366;3467.3065386922717;3490.7556471046782;3492.336456073338;6534.901976470357;6607.768728094494;6663.5335526513645;6667.033225198578;6678.799636010927;6571.145751052332;6586.473082153512;6590.835229119214;6591.604503729792;6596.4393026592315;6691.356914018936;6705.195376554747;6707.5975441473665;6712.496562757813;6719.092922455406;6384.936150638434;6493.740250389931;6529.608223506605;6533.901991470227;6534.542582019403;6193.349698281616;6338.302786693368;6363.5545511813725;6368.395002474757;6369;6691.197056353269;6700.162479690039;6707.5975441473665;6709.899351509829;6717.529772915849;4267.722598031118;4270.807813648331;4280.807363668705;4283.914321713611;4287.656987440935;6431.389018043278;6433.228012638513;6433.646149461637;6433.871322573429;6447.258565265054;6151.6001459904965;6272.18461599989;6291.905621415591;6296.212973378328;6302.747890084345;6232.688365581794;6235.719392627433;6240.469560087262;6248.843778905563;6257.186565746606;6043.3352331244405;6067.362926892789;6068.817935461943;6074.696265186812;6079.878402431838;6247.3440288769025;6281.7173227203975;6286.5599408041;6286.65423401699;6297.307296197506;6002.249718785152;6090.482309003784;6130.816075517741;6149.108379285068;6172.907406388818 01:57:55 INFO - PROCESS | 394 | |5;yui.html;651.7523341130371;653.5163978655793;659.518551457436;662.073097663271;669.2103318084659;13993.160410375385;14236.359363828627;14264.928675356634;14303.713925721479;14347.78478322826;13023;13160.144590601629;13175.538856140038;13180.670483237924;13226.735465290689;674.2078058281525;797.6729540888223;802.2939812964584;818.6561644109488;821.5029906906325;825.2655136928139;828.2131974624101;828.6188353357463;829.2371018662844;832.2592892325835;706.8586282743446;860.2043110123111;870.4472659861002;871.4684042733927;874.7594411536815;838.9161083891623;860.406319639453;871.5075982070142;871.930245580352;872.2760109109456;637.687533108778;638.3297537585516;639.5395315372971;639.9776007839703;640.2285246278224;13411.396487158101;13484.325783710874;13487.123336983163;13498.122622029538;13502.594922152352;12639.684007899876;12925.612231633066;12964.87035129646;13071.869281307161;13125.474981000749;10579.523921423555;10656.573737050508;10732.356058636507;10832.187585931008;10875.075618572431;3854.8458061677497;3864.768113913146;3875.4961854958956;3891.727579069466;3900.2004589059175;55048.72475637596;55886;55929.44070559283;55939.72030139864;55945;9260.722178334661;10161.390316581028;10276.588936442608;10526.842097368546;10745.570177192825;17012.48962531126;17226.569335766457;17227;17242.224099915533;17249.56876078108;7739.5743234122665;7980.201979801974;8104.189581041848;8256.669733210605;8350.749477515685;4587.770611469413;4686.086213188463;4718.386609740712;4794.832180873653;4829.637777166727;3223.7421006319437;3247.594050743657;3256.706896379337;3279.262166012628;3280.2291461506525;573.667272981678;579.3540202673988;617.4443001298866;626.151564629929;638.7668500997103;594.3759052994338;608.4706305514231;610.1086631442492;632.1497585747163;659.9274079851212;8580.613872375758;8686;8869.201771840566;8909.910900890907;9055.003949565542;565.7171414292853;571.0777094991558;618.6999305336908;633.0472638678851;633.6293268437923;4068.816903239361;4202.222588821078;4427.889302767457;4483.574060464251;4597.540245975376;57169.714151428976;59882.401175988554;59940;60541.394586054455;60678.696606516685;51573.96852062938;51655.74172129115;51846.74076629593;53468;53579.46420535823;51585;52056.73971630118;53022.99999999923;53482;54659.72670136624;9464.19554337889;9522.238220942447;9633.373830700983;9660.565274562801;9738.415695058318;38289;40543.59456405398;41391;41513.37729934114;42231.577684222764;43438.782806085765;46500.767496162305;48544.75727621339;50722.492775071776;53602.46397536131;10654;11191.216614836883;11248.437578120898;11272.774544509228;11364.829527557258;11892.524299028288;12275;12782.872171278168;12934.159279646792;13206.27365494907;11972.940135299268;12365;12637.684057898627;12668.366581670694;12674.809877851656;11469;11474.368909710047;11661.416929153678;11725.179237453638;11877.940610296893;11343.376114313793;11893.94053029764;12093.516259349528;12299.815502767287;12448.377581120727;10008.64969726056;10029.749256268651;10075.899241007495;10514.842277365999;10636.468176591294;10457.215708821717;10587.364758114538;10641.255112142077;10773.838392424277;10783.676489705322 01:57:55 INFO - PROCESS | 394 | __end_tp_report 01:57:55 INFO - PROCESS | 394 | __start_cc_report 01:57:55 INFO - PROCESS | 394 | _x_x_mozilla_cycle_collect,800 01:57:55 INFO - PROCESS | 394 | __end_cc_report 01:57:55 INFO - PROCESS | 394 | __startTimestamp1458291475980__endTimestamp 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | ------- Summary: start ------- 01:57:55 INFO - PROCESS | 394 | Number of tests: 6 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#0] dojo.html Cycles:165 Average:5174.51 Median:5390.68 stddev:594.03 (11.0%) stddev-sans-first:569.92 01:57:55 INFO - PROCESS | 394 | Values: 2961.7 2994.8 3019.9 3032.4 3063.6 4999.1 5193.8 5218.2 5228.8 5262.8 5259.5 5269.7 5299.4 5311.4 5342.0 4707.6 4715.6 4724.6 4726.5 4842.8 4780.3 4780.6 4808.1 4829.6 4885.0 4673.7 4674.0 4733.5 4740.2 4759.7 4678.6 4695.9 4696.4 4717.5 4739.3 4598.1 4675.2 4688.4 4721.1 4742.0 5095.6 5101.2 5112.8 5114.9 5148.6 5501.5 5509.4 5509.8 5510.8 5557.4 5481.7 5548.7 5584.0 5636.8 5696.3 5262.4 5273.3 5277.5 5282.7 5293.3 5757.1 5777.9 5778.3 5779.3 5785.7 5376.1 5453.7 5507.2 5534.3 5559.9 5512.8 5522.7 5524.2 5531.7 5533.0 5507.6 5508.6 5510.8 5511.4 5554.4 5375.1 5503.5 5560.6 5567.5 5603.0 4257.2 4287.1 4287.9 4292.2 4329.4 3669.4 3823.3 3826.1 3839.4 3879.5 5169.6 5194.5 5219.5 5258.3 5272.1 5600.3 5664.1 5667.0 5668.4 5669.9 5130.2 5197.6 5278.0 5352.2 5394.7 4618.8 4633.3 4637.4 4651.1 4677.1 5718.4 5721.7 5726.8 5726.9 5776.7 5384.9 5531.7 5533.4 5534.2 5629.9 5821.3 5827.0 5839.7 5860.8 5894.9 5506.1 5532.7 5537.0 5542.2 5548.8 5490.9 5520.3 5578.4 5605.2 5606.6 5437.5 5441.7 5446.0 5455.9 5497.5 5390.7 5419.8 5431.3 5434.8 5486.1 5163.4 5273.6 5325.2 5387.1 5441.7 5517.6 5537.1 5539.3 5552.4 5559.1 5379.0 5438.6 5438.7 5440.3 5490.6 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#1] ext.html Cycles:180 Average:50355.60 Median:18263.52 stddev:87176.71 (477.3%) stddev-sans-first:87341.07 01:57:55 INFO - PROCESS | 394 | Values: 555.8 582.4 611.1 626.1 637.9 33117.5 38406.0 38839.8 38894.4 38959.6 44344.8 45316.1 45397.5 45443.5 45493.1 7829.1 7960.3 7971.6 8723.2 8977.4 10310.7 10572.4 10575.4 10582.0 10586.9 10342.0 10425.8 10436.4 10441.4 10444.2 10203.2 10286.5 10291.3 10292.6 10293.5 10280.2 10438.6 10452.8 10463.2 10470.8 41454.4 41514.0 41569.6 41588.4 41606.2 3409.5 3880.8 4162.1 4165.1 4288.0 31988.8 32417.8 32497.5 32673.0 32975.5 3840.9 3920.1 3967.7 3971.9 4149.3 312082.0 314431.0 314673.0 315036.0 315239.0 46149.3 46162.1 61758.7 62163.4 62229.0 43716.1 44242.0 44314.0 44444.3 44566.3 15895.4 15985.1 16020.9 16056.8 16064.3 12752.1 12857.3 12859.5 12860.8 12862.7 15566.9 15596.5 15597.9 15610.4 15615.9 5901.8 6087.2 6147.5 6148.9 6214.6 1017.7 1099.9 1155.4 1159.6 1167.9 31411.2 32139.0 32171.8 32678.2 32681.7 1196.2 1199.0 1234.3 1237.0 1258.5 16394.6 16710.6 16720.6 16737.6 16958.9 386792.0 388163.0 389752.0 390606.5 390874.0 55766.0 56220.0 56227.7 56282.0 56286.0 1196.5 1365.1 1386.8 1399.0 1429.0 27562.3 29055.0 29128.0 29417.3 29706.0 42652.8 53526.2 54063.0 54143.7 54265.5 284200.0 285425.0 286292.0 287047.0 288558.0 37582.2 44485.3 45202.0 45556.5 45567.3 43237.8 44199.6 44223.8 47148.3 47314.5 37240.4 39246.4 39573.2 39820.8 39989.4 37486.8 37861.6 38578.0 39613.4 39731.2 40297.0 40833.0 41008.2 41123.0 41168.4 31562.0 32156.4 32389.5 32429.8 32688.7 27525.7 27603.0 27725.4 27927.7 27967.9 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#2] jquery.html Cycles:180 Average:27377.97 Median:2517.80 stddev:79811.66 (3169.9%) stddev-sans-first:80009.71 01:57:55 INFO - PROCESS | 394 | Values: 328.4 329.9 340.3 345.2 347.3 17358.4 17983.7 18035.9 19182.9 19212.3 17327.3 17723.9 17989.6 18076.8 18089.0 5166.7 5169.6 5386.8 5387.2 5389.4 3946.7 5323.8 5369.7 5565.0 5790.6 5724.9 5801.2 5803.3 5803.7 5807.9 5612.9 5687.9 5715.0 5762.6 5763.4 3547.4 4913.9 5046.3 5052.4 5114.4 20200.0 20536.2 20539.7 20826.5 20851.5 2130.6 2282.2 2307.6 2507.0 2528.6 9086.4 9126.2 9134.7 12153.6 13681.5 1979.5 1984.2 2027.2 2109.5 2149.6 68415.3 70819.3 70896.0 71063.3 71266.0 10116.6 10122.5 10129.1 10135.6 10243.4 12631.3 12726.9 12737.5 12739.4 12758.1 7814.2 8032.3 8061.0 8080.5 8158.2 8182.0 8245.1 8267.0 8348.2 8387.2 4213.6 4236.1 4268.1 4268.6 4314.8 1616.3 1673.5 1688.2 1744.1 1748.2 1002.0 1031.8 1055.1 1057.0 1067.6 16964.8 17832.6 17841.9 18101.8 18413.9 965.1 981.6 1000.9 1024.4 1070.1 9875.2 9903.6 10276.8 10303.9 10353.2 449529.0 452381.0 505130.0 507710.0 512995.0 72391.6 75322.0 79144.0 79344.6 85692.6 1061.7 1089.5 1109.7 1110.8 1111.6 16450.8 16520.2 16652.7 16680.9 16776.4 34758.3 35772.0 36791.8 36893.0 37365.4 49973.5 53572.7 53843.5 53921.5 53982.7 7395.0 7416.5 7569.6 7575.8 7635.7 8424.1 11852.6 12268.0 12523.7 12589.1 10379.0 10477.2 10669.3 10725.1 10792.6 10696.9 10778.4 10942.5 11164.3 11329.6 10513.2 10772.2 10994.5 11137.7 11241.7 7320.6 7324.5 7358.4 7440.4 7550.2 10957.8 10995.4 11121.7 11123.5 11161.7 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#3] mootools.html Cycles:180 Average:5499.62 Median:6370.97 stddev:2908.16 (45.6%) stddev-sans-first:2899.67 01:57:55 INFO - PROCESS | 394 | Values: 1358.7 1499.2 1500.4 1672.7 1790.0 7530.8 7685.8 7686.4 7690.4 7695.4 7634.3 7683.5 7772.5 7774.7 7798.4 1975.2 2018.6 2211.2 2303.0 2327.5 2274.3 2279.0 2282.5 2283.8 2286.4 2183.5 2212.8 2258.6 2258.7 2260.4 2212.8 2236.7 2244.6 2250.2 2294.8 2244.1 2254.0 2263.5 2265.7 2272.2 7864.4 7904.0 7930.5 7943.2 7948.0 4700.3 4796.9 4799.0 4804.8 4806.7 3053.7 3086.7 3122.4 3152.9 3158.3 996.1 1003.7 1019.7 1022.2 1040.0 10626.7 10713.9 10794.5 10806.0 10809.2 3969.2 4099.4 4111.4 4160.8 4176.5 8692.0 8739.0 8833.3 8837.5 8911.5 4801.1 4818.8 4834.9 4835.2 4835.4 3838.3 4310.3 4374.2 4377.9 4391.9 3533.8 3615.6 3648.0 3656.2 3658.2 1086.6 1102.0 1106.2 1122.6 1127.0 1241.2 1266.4 1268.9 1404.5 1422.8 7519.4 7609.2 7718.7 7733.3 7734.7 469.4 473.3 474.4 477.3 477.8 5832.8 5855.6 5889.6 5938.7 5944.4 9187.1 9803.9 9805.1 9809.6 9951.8 9640.0 9648.7 9709.9 9743.8 9769.3 7305.3 7500.5 7515.1 7586.9 7598.7 7266.9 7349.2 7355.0 7368.5 7391.6 8587.5 8664.0 8670.5 8780.2 8824.2 8177.6 8968.1 9066.9 9119.4 9135.5 6099.2 6224.7 6654.6 7017.7 7119.8 7432.7 7467.7 7473.5 7490.4 7512.4 6685.2 6868.9 6889.3 6995.7 7065.0 6879.7 6912.8 6974.9 6999.5 7000.4 6930.2 6931.9 7027.9 7118.2 7169.4 6615.0 6623.2 6657.0 6671.7 6672.1 6517.2 6712.4 6733.9 6748.3 6749.8 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#4] prototype.html Cycles:180 Average:5216.56 Median:6045.87 stddev:1602.20 (26.5%) stddev-sans-first:1563.68 01:57:55 INFO - PROCESS | 394 | Values: 303.3 306.0 313.7 316.5 321.7 5965.7 6010.2 6027.4 6030.3 6042.9 5930.4 5951.8 5965.4 5968.3 5969.2 4280.4 4425.3 4515.5 4525.8 4533.9 4490.3 4522.1 4528.8 4530.0 4530.7 4306.5 4479.4 4486.2 4490.6 4491.9 4407.0 4471.8 4472.9 4477.9 4484.3 3889.1 3896.4 3897.2 3902.4 3905.3 5733.6 5739.5 5744.7 5744.7 5755.1 5169.6 5178.3 5179.0 5180.0 5182.1 6210.5 6211.0 6222.9 6225.0 6231.0 4082.8 4199.7 4200.7 4213.6 4287.7 6515.5 6550.8 6565.0 6581.8 6582.7 4321.5 4321.9 4325.9 4327.3 4327.8 4358.6 4375.5 4380.9 4382.7 4383.9 5120.2 5121.8 5122.1 5125.7 5130.4 6155.5 6311.7 6312.5 6316.6 6319.4 1516.5 1516.9 1534.7 1536.4 1538.5 947.4 990.2 992.4 1004.0 1018.0 6023.6 6027.6 6061.1 6076.8 6077.9 6480.7 6485.5 6486.9 6487.8 6493.0 6048.4 6057.8 6059.5 6064.5 6068.8 3450.4 3451.7 3467.3 3490.8 3492.3 6534.9 6607.8 6663.5 6667.0 6678.8 6571.1 6586.5 6590.8 6591.6 6596.4 6691.4 6705.2 6707.6 6712.5 6719.1 6384.9 6493.7 6529.6 6533.9 6534.5 6193.3 6338.3 6363.6 6368.4 6369.0 6691.2 6700.2 6707.6 6709.9 6717.5 4267.7 4270.8 4280.8 4283.9 4287.7 6431.4 6433.2 6433.6 6433.9 6447.3 6151.6 6272.2 6291.9 6296.2 6302.7 6232.7 6235.7 6240.5 6248.8 6257.2 6043.3 6067.4 6068.8 6074.7 6079.9 6247.3 6281.7 6286.6 6286.7 6297.3 6002.2 6090.5 6130.8 6149.1 6172.9 01:57:55 INFO - PROCESS | 394 | 01:57:55 INFO - PROCESS | 394 | [#5] yui.html Cycles:180 Average:14778.15 Median:25549.15 stddev:17433.99 (68.2%) stddev-sans-first:17450.62 01:57:55 INFO - PROCESS | 394 | Values: 651.8 653.5 659.5 662.1 669.2 13993.2 14236.4 14264.9 14303.7 14347.8 13023.0 13160.1 13175.5 13180.7 13226.7 674.2 797.7 802.3 818.7 821.5 825.3 828.2 828.6 829.2 832.3 706.9 860.2 870.4 871.5 874.8 838.9 860.4 871.5 871.9 872.3 637.7 638.3 639.5 640.0 640.2 13411.4 13484.3 13487.1 13498.1 13502.6 12639.7 12925.6 12964.9 13071.9 13125.5 10579.5 10656.6 10732.4 10832.2 10875.1 3854.8 3864.8 3875.5 3891.7 3900.2 55048.7 55886.0 55929.4 55939.7 55945.0 9260.7 10161.4 10276.6 10526.8 10745.6 17012.5 17226.6 17227.0 17242.2 17249.6 7739.6 7980.2 8104.2 8256.7 8350.7 4587.8 4686.1 4718.4 4794.8 4829.6 3223.7 3247.6 3256.7 3279.3 3280.2 573.7 579.4 617.4 626.2 638.8 594.4 608.5 610.1 632.1 659.9 8580.6 8686.0 8869.2 8909.9 9055.0 565.7 571.1 618.7 633.0 633.6 4068.8 4202.2 4427.9 4483.6 4597.5 57169.7 59882.4 59940.0 60541.4 60678.7 51574.0 51655.7 51846.7 53468.0 53579.5 51585.0 52056.7 53023.0 53482.0 54659.7 9464.2 9522.2 9633.4 9660.6 9738.4 38289.0 40543.6 41391.0 41513.4 42231.6 43438.8 46500.8 48544.8 50722.5 53602.5 10654.0 11191.2 11248.4 11272.8 11364.8 11892.5 12275.0 12782.9 12934.2 13206.3 11972.9 12365.0 12637.7 12668.4 12674.8 11469.0 11474.4 11661.4 11725.2 11877.9 11343.4 11893.9 12093.5 12299.8 12448.4 10008.6 10029.7 10075.9 10514.8 10636.5 10457.2 10587.4 10641.3 10773.8 10783.7 01:57:55 INFO - PROCESS | 394 | -------- Summary: end -------- 01:57:55 INFO - PROCESS | 394 | 01:57:56 INFO - TEST-INFO | 394: exit 0 01:57:56 INFO - TEST-OK | dromaeo_css | took 1111545ms 01:57:56 INFO - TEST-START | kraken 01:57:56 INFO - operating with platform_type : linux_ 01:57:56 INFO - Initialising browser for kraken test... 01:57:56 INFO - TEST-INFO | started process 586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCHx0Aw/profile http://localhost:37499/getInfo.html) 01:58:01 INFO - PROCESS | 586 | __metrics Screen width/height:1600/1200 01:58:01 INFO - PROCESS | 586 | colorDepth:24 01:58:01 INFO - PROCESS | 586 | Browser inner width/height: 1024/697 01:58:01 INFO - PROCESS | 586 | __metrics 01:58:02 ERROR - PROCESS | 586 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:58:02 INFO - PROCESS | 586 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 01:58:03 INFO - TEST-INFO | 586: exit 0 01:58:03 INFO - Browser initialized. 01:58:03 INFO - Running cycle 1/1 for kraken test... 01:58:03 INFO - TEST-INFO | started process 672 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCHx0Aw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:14 INFO - PROCESS | 672 | RSS: Main: 153288704 01:58:14 INFO - PROCESS | 672 | 01:58:17 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37499/tests/kraken/driver.html?testName=audio-beat-detection) 01:58:17 INFO - PROCESS | 672 | RSS: Main: 196792320 01:58:17 INFO - PROCESS | 672 | 01:58:20 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37499/tests/kraken/driver.html?testName=audio-dft) 01:58:21 INFO - PROCESS | 672 | RSS: Main: 186499072 01:58:21 INFO - PROCESS | 672 | 01:58:24 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37499/tests/kraken/driver.html?testName=audio-fft) 01:58:24 INFO - PROCESS | 672 | RSS: Main: 168697856 01:58:24 INFO - PROCESS | 672 | 01:58:26 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37499/tests/kraken/driver.html?testName=audio-oscillator) 01:58:27 INFO - PROCESS | 672 | RSS: Main: 173383680 01:58:27 INFO - PROCESS | 672 | 01:58:29 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:58:30 INFO - PROCESS | 672 | RSS: Main: 173445120 01:58:30 INFO - PROCESS | 672 | 01:58:33 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37499/tests/kraken/driver.html?testName=imaging-darkroom) 01:58:33 INFO - PROCESS | 672 | RSS: Main: 173662208 01:58:33 INFO - PROCESS | 672 | 01:58:37 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37499/tests/kraken/driver.html?testName=imaging-desaturate) 01:58:37 INFO - PROCESS | 672 | RSS: Main: 176250880 01:58:37 INFO - PROCESS | 672 | 01:58:40 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37499/tests/kraken/driver.html?testName=json-parse-financial) 01:58:41 INFO - PROCESS | 672 | RSS: Main: 175693824 01:58:41 INFO - PROCESS | 672 | 01:58:42 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:58:43 INFO - PROCESS | 672 | RSS: Main: 185540608 01:58:43 INFO - PROCESS | 672 | 01:58:44 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:58:45 INFO - PROCESS | 672 | RSS: Main: 183386112 01:58:45 INFO - PROCESS | 672 | 01:58:47 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:48 INFO - PROCESS | 672 | RSS: Main: 192274432 01:58:48 INFO - PROCESS | 672 | 01:58:50 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:51 INFO - PROCESS | 672 | RSS: Main: 197951488 01:58:51 INFO - PROCESS | 672 | 01:58:53 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:54 INFO - PROCESS | 672 | RSS: Main: 197509120 01:58:54 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | Cycle 1(1): loaded http://localhost:37499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37499/tests/kraken/driver.html?testName=ai-astar) 01:58:55 INFO - PROCESS | 672 | RSS: Main: 257077248 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | __start_tp_report 01:58:55 INFO - PROCESS | 672 | _x_x_mozilla_page_load 01:58:55 INFO - PROCESS | 672 | _x_x_mozilla_page_load_details 01:58:55 INFO - PROCESS | 672 | |i|pagename|runs| 01:58:55 INFO - PROCESS | 672 | |0;ai-astar;110;112;103;108;109;109;98;110;110;110 01:58:55 INFO - PROCESS | 672 | |1;audio-beat-detection;146;124;148;163;131;155;155;125;170;133 01:58:55 INFO - PROCESS | 672 | |2;audio-dft;161;161;161;161;161;161;160;163;162;160 01:58:55 INFO - PROCESS | 672 | |3;audio-fft;75;71;97;100;72;75;74;117;106;75 01:58:55 INFO - PROCESS | 672 | |4;audio-oscillator;93;93;144;92;102;93;146;91;93;132 01:58:55 INFO - PROCESS | 672 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;116;117 01:58:55 INFO - PROCESS | 672 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;144;145 01:58:55 INFO - PROCESS | 672 | |7;imaging-desaturate;95;96;96;95;96;95;96;96;95;96 01:58:55 INFO - PROCESS | 672 | |8;json-parse-financial;59;59;58;60;66;58;59;68;57;56 01:58:55 INFO - PROCESS | 672 | |9;json-stringify-tinderbox;61;61;60;60;60;60;61;60;60;60 01:58:55 INFO - PROCESS | 672 | |10;stanford-crypto-aes;77;84;78;79;79;78;79;79;80;78 01:58:55 INFO - PROCESS | 672 | |11;stanford-crypto-ccm;112;113;110;109;120;115;123;116;113;131 01:58:55 INFO - PROCESS | 672 | |12;stanford-crypto-pbkdf2;141;141;139;141;142;145;136;142;144;147 01:58:55 INFO - PROCESS | 672 | |13;stanford-crypto-sha256-iterative;62;63;66;63;64;62;63;64;63;63 01:58:55 INFO - PROCESS | 672 | __end_tp_report 01:58:55 INFO - PROCESS | 672 | __start_cc_report 01:58:55 INFO - PROCESS | 672 | _x_x_mozilla_cycle_collect,1059 01:58:55 INFO - PROCESS | 672 | __end_cc_report 01:58:55 INFO - PROCESS | 672 | __startTimestamp1458291535977__endTimestamp 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | ------- Summary: start ------- 01:58:55 INFO - PROCESS | 672 | Number of tests: 14 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:4.20 (3.8%) stddev-sans-first:4.39 01:58:55 INFO - PROCESS | 672 | Values: 110.0 112.0 103.0 108.0 109.0 109.0 98.0 110.0 110.0 110.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:151.50 stddev:16.12 (10.6%) stddev-sans-first:17.10 01:58:55 INFO - PROCESS | 672 | Values: 146.0 124.0 148.0 163.0 131.0 155.0 155.0 125.0 170.0 133.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 01:58:55 INFO - PROCESS | 672 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 160.0 163.0 162.0 160.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#3] audio-fft Cycles:10 Average:86.20 Median:74.50 stddev:17.02 (22.8%) stddev-sans-first:17.56 01:58:55 INFO - PROCESS | 672 | Values: 75.0 71.0 97.0 100.0 72.0 75.0 74.0 117.0 106.0 75.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.50 stddev:23.09 (25.0%) stddev-sans-first:23.85 01:58:55 INFO - PROCESS | 672 | Values: 93.0 93.0 144.0 92.0 102.0 93.0 146.0 91.0 93.0 132.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:58:55 INFO - PROCESS | 672 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 01:58:55 INFO - PROCESS | 672 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 01:58:55 INFO - PROCESS | 672 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:3.89 (6.6%) stddev-sans-first:4.11 01:58:55 INFO - PROCESS | 672 | Values: 59.0 59.0 58.0 60.0 66.0 58.0 59.0 68.0 57.0 56.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 01:58:55 INFO - PROCESS | 672 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.91 (2.4%) stddev-sans-first:1.87 01:58:55 INFO - PROCESS | 672 | Values: 77.0 84.0 78.0 79.0 79.0 78.0 79.0 79.0 80.0 78.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:115.50 stddev:6.75 (5.8%) stddev-sans-first:6.98 01:58:55 INFO - PROCESS | 672 | Values: 112.0 113.0 110.0 109.0 120.0 115.0 123.0 116.0 113.0 131.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:142.00 stddev:3.08 (2.2%) stddev-sans-first:3.26 01:58:55 INFO - PROCESS | 672 | Values: 141.0 141.0 139.0 141.0 142.0 145.0 136.0 142.0 144.0 147.0 01:58:55 INFO - PROCESS | 672 | 01:58:55 INFO - PROCESS | 672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 01:58:55 INFO - PROCESS | 672 | Values: 62.0 63.0 66.0 63.0 64.0 62.0 63.0 64.0 63.0 63.0 01:58:55 INFO - PROCESS | 672 | -------- Summary: end -------- 01:58:55 INFO - PROCESS | 672 | 01:58:56 INFO - TEST-INFO | 672: exit 0 01:58:56 INFO - TEST-OK | kraken | took 60222ms 01:58:56 INFO - SUITE-END | took 1171s 01:58:57 INFO - Completed test suite (00:19:31) 01:58:57 INFO - javascript benchmark 01:58:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2961.6890226526216, 2994.775391845612, 3019.939601207976, 3032.3632037272173, 3063.571100045994, 4999.050180465718, 5193.792248310063, 5218.243354713569, 5228.816991405297, 5262.81580144695, 5259.526642602165, 5269.736513174345, 5299.390570084442, 5311.362636483617, 5342.011727830344, 4707.576318131368, 4715.57559819617, 4724.574788269055, 4726.456457507379, 4842.806287748504, 4780.3307536944685, 4780.5936495397755, 4808.086463571927, 4829.637777166709, 4885.022995400916, 4673.742944138071, 4673.953260467403, 4733.455652599961, 4740.241561350202, 4759.7382143981895, 4678.649101317381, 4695.929561056587, 4696.436427628706, 4717.504662010508, 4739.312799644067, 4598.149342371638, 4675.2052151134385, 4688.390509233812, 4721.102990431807, 4742.027884283748, 5095.643304968654, 5101.234814777776, 5112.846614601568, 5114.897702045975, 5148.613853960968, 5501.5323697485765, 5509.449055094498, 5509.807156749494, 5510.8071217507595, 5557.3886872444, 5481.698506582136, 5548.69482178484, 5583.972080139614, 5636.802711905064, 5696.316442026983, 5262.447443018466, 5273.34083239595, 5277.525022747933, 5282.683039017671, 5293.311869456985, 5757.107648314518, 5777.88444231113, 5778.3354914184565, 5779.335376431764, 5785.739641716133, 5376.059189641797, 5453.700046497402, 5507.228987941691, 5534.252875861787, 5559.8888022239325, 5512.751926163332, 5522.723863806794, 5524.226608274845, 5531.723413829292, 5532.97639936605, 5507.642003269774, 5508.586855985817, 5510.8071217507195, 5511.421300763443, 5554.416786237468, 5375.139977603565, 5503.477169668875, 5560.638558493685, 5567.526760225426, 5603.0, 4257.212415703105, 4287.142571485715, 4287.914241715148, 4292.163028209469, 4329.393884856123, 3669.3578623740736, 3823.292690852146, 3826.0626146594263, 3839.404892241707, 3879.4956655634587, 5169.638125331266, 5194.506521880416, 5219.5041471060185, 5258.2638430619745, 5272.077386457355, 5600.271964644651, 5664.0937450007805, 5666.9716651416475, 5668.404817494104, 5669.858253543694, 5130.204818253177, 5197.58419326453, 5278.0, 5352.223927530564, 5394.73026348681, 4618.815247390066, 4633.2818413146015, 4637.397138372057, 4651.069786042805, 4677.064587082597, 5718.428157184331, 5721.685307308138, 5726.799562015392, 5726.856828579235, 5776.7111644418455, 5384.865378365572, 5531.695756733257, 5533.418991005967, 5534.225208470737, 5629.943700563106, 5821.330546986981, 5826.980278451339, 5839.678817665069, 5860.794872179454, 5894.941050589439, 5506.1190209566275, 5532.695701736443, 5537.0, 5542.168674698827, 5548.778048878, 5490.91763623538, 5520.282363292747, 5578.386377498553, 5605.159226116115, 5606.635568688022, 5437.537809286255, 5441.673499590037, 5445.972770136124, 5455.890882182255, 5497.47773961473, 5390.676559406448, 5419.783208671609, 5431.293931788842, 5434.782608695607, 5486.094794359045, 5163.3545806774155, 5273.551748101454, 5325.201219817059, 5387.111126664056, 5441.673499590037, 5517.61376703643, 5537.086380747131, 5539.279893613804, 5552.416996215339, 5559.11054231321, 5379.0, 5438.646487978269, 5438.728063596884, 5440.292761940922, 5490.560755139659], "unit": "score", "name": "dojo.html", "value": 5134.126631327411}, {"lowerIsBetter": false, "replicates": [555.7582451633542, 582.350678992923, 611.0864257934387, 626.1234272019173, 637.8756142552203, 33117.50323745143, 38406.0, 38839.80580097103, 38894.41658375126, 38959.61040389599, 44344.77827610866, 45316.0936781265, 45397.54602453975, 45443.54556454434, 45493.090138197214, 7829.138794732575, 7960.323372513343, 7971.561564113971, 8723.171298726611, 8977.371583989123, 10310.7422314442, 10572.365658060502, 10575.365478071302, 10582.0, 10586.947065264663, 10342.0, 10425.843612345821, 10436.425996570186, 10441.42572158531, 10444.164466842634, 10203.234757393226, 10286.485675716222, 10291.33106348085, 10292.639757608522, 10293.53679084443, 10280.228982826244, 10438.63464778729, 10452.79094418115, 10463.162946964301, 10470.79058418835, 41454.37818432726, 41514.0, 41569.58430415718, 41588.37617435741, 41606.1678766426, 3409.539712138879, 3880.844766209348, 4162.084341444877, 4165.12532368203, 4287.957120428819, 31988.840055799807, 32417.837910810296, 32497.51253731196, 32673.0, 32975.50536741951, 3840.9039774005873, 3920.1289842490387, 3967.7222594418404, 3971.9007024824323, 4149.294619914622, 312082.0, 314431.0, 314673.0, 315036.0, 315239.0, 46149.30776038362, 46162.076758464646, 61758.69120654368, 62163.37836621666, 62229.0, 43716.12567748627, 44242.0, 44314.0, 44444.333335, 44566.331505027454, 15895.443659471863, 15985.12081835487, 16020.919895400448, 16056.839431605767, 16064.27710753019, 12752.107352485236, 12857.292848893214, 12859.549915752903, 12860.807087893689, 12862.678433039062, 15566.922165389327, 15596.532104036896, 15597.922010389875, 15610.3755849767, 15615.921920390552, 5901.793437229762, 6087.208662873798, 6147.508199344042, 6148.8770224595255, 6214.564980451325, 1017.6539976408056, 1099.9010089092021, 1155.3760969076604, 1159.6405114414558, 1167.8656954450346, 31411.214719631735, 32139.0, 32171.839140804615, 32678.18304542358, 32681.673183267863, 1196.1567095197865, 1198.9820152697716, 1234.2779474007627, 1237.0227520259075, 1258.4966013594635, 16394.590135246715, 16710.58223544421, 16720.58198545022, 16737.581560460843, 16958.915205423895, 386792.0, 388163.0, 389752.0, 390606.46967652073, 390874.0, 55766.0, 56220.0, 56227.71886140543, 56282.0, 56286.0, 1196.5154112584416, 1365.0512893538896, 1386.7850483175123, 1399.0067052392915, 1428.992855035718, 27562.310942225802, 29055.0, 29128.0, 29417.264568385963, 29706.0, 42652.78673606612, 53526.197107042644, 54063.0, 54143.729281354914, 54265.45734542604, 284200.0, 285425.0, 286292.0, 287047.0, 288558.0, 37582.2483550322, 44485.33272000858, 45202.0, 45556.544434556556, 45567.31649025201, 43237.78381108074, 44199.558004419545, 44223.77888110539, 47148.29277560908, 47314.52685473239, 37240.44139337966, 39246.4113038299, 39573.20853582855, 39820.80089599534, 39989.40015899706, 37486.812565937, 37861.621383786915, 38578.0, 39613.40579891361, 39731.205375892896, 40297.0, 40833.0, 41008.17983640251, 41123.0, 41168.38247426231, 31562.0, 32156.356872862878, 32389.514157287187, 32429.837850810596, 32688.673113269513, 27525.724742752314, 27603.0, 27725.445491090468, 27927.720722792514, 27967.860160699067], "unit": "score", "name": "ext.html", "value": 19601.308312063007}, {"lowerIsBetter": false, "replicates": [328.4498465071006, 329.8927848449255, 340.2752137946174, 345.2353038020784, 347.3019231344996, 17358.392456264035, 17983.73024404633, 18035.909820450895, 19182.90408547959, 19212.327568535104, 17327.30690772371, 17723.91138044311, 17989.64020719588, 18076.819231807676, 18089.0, 5166.741662916848, 5169.612279079065, 5386.78452861885, 5387.19192121181, 5389.434109418514, 3946.6842652587866, 5323.840284791462, 5369.731513424333, 5564.972175139119, 5790.623609465392, 5724.91226666934, 5801.245838041049, 5803.303603567578, 5803.680797556132, 5807.941920580783, 5612.915806262909, 5687.886242275152, 5715.028445164311, 5762.625429347079, 5763.366029736726, 3547.4324108142832, 4913.901721965576, 5046.343975283226, 5052.393712754456, 5114.386273647149, 20200.0, 20536.17855285787, 20539.691904621443, 20826.47933801652, 20851.478713032146, 2130.5632345369163, 2282.2468585366787, 2307.619242824932, 2506.962395564068, 2528.645989561463, 9086.409383390059, 9126.17864392208, 9134.680286190018, 12153.630042141785, 13681.452741890313, 1979.4952287166825, 1984.2360691133872, 2027.1688607670785, 2109.5253567947243, 2149.570085982794, 68415.31584684139, 70819.29180708178, 70896.0, 71063.28936710619, 71266.0, 10116.595336186618, 10122.493875306205, 10129.088382045504, 10135.594576217016, 10243.38539687621, 12631.305278209788, 12726.872731272753, 12737.490500380067, 12739.36303184837, 12758.106932514635, 7814.233243769544, 8032.277095061472, 8060.959695201486, 8080.515169089874, 8158.184181581794, 8181.959090204511, 8245.093039765621, 8267.0, 8348.165183481724, 8387.245147936716, 4213.6207741302815, 4236.131593023423, 4268.125034367947, 4268.615824575803, 4314.80583373749, 1616.3049888547803, 1673.4979506148106, 1688.1981058996878, 1744.0582085673848, 1748.1783561725968, 1001.998001998002, 1031.8091153136693, 1055.1400608504198, 1056.9852941176557, 1067.6209945469402, 16964.830351696324, 17832.643347132984, 17841.910790445963, 18101.818981810276, 18413.90793046053, 965.1217392173089, 981.6220755009373, 1000.9040101089296, 1024.4263212600968, 1070.1385384765183, 9875.160611347972, 9903.554340054714, 10276.794464110826, 10303.896961030443, 10353.171746260281, 449529.0, 452381.0, 505130.0, 507710.0, 512995.0, 72391.63804180945, 75322.0, 79144.0, 79344.60327698325, 85692.57153714192, 1061.7186445591924, 1089.5042755546208, 1109.6837401340579, 1110.8444817725524, 1111.6276047524009, 16450.75323870119, 16520.173991300147, 16652.666946660756, 16680.916595416944, 16776.412825551048, 34758.30483390368, 35772.0, 36791.81604091962, 36893.0, 37365.4395184067, 49973.50026499688, 53572.732136339066, 53843.46156538385, 53921.460785391646, 53982.730086349315, 7394.964704941205, 7416.517926334771, 7569.583672897823, 7575.772726818204, 7635.656395462106, 8424.073351931405, 11852.585159519376, 12268.0, 12523.686907827378, 12589.118761686594, 10379.0, 10477.16182705397, 10669.253152279576, 10725.08836748885, 10792.622258220925, 10696.893031069902, 10778.407187604756, 10942.507587158438, 11164.330140191614, 11329.603463879055, 10513.211509136998, 10772.24594278393, 10994.450277485934, 11137.721556961142, 11241.71895702614, 7320.597367144858, 7324.487285889936, 7358.411327093927, 7440.4419668524, 7550.244975502405, 10957.780844383227, 10995.395253261147, 11121.666350009513, 11123.499442524944, 11161.665150045512], "unit": "score", "name": "jquery.html", "value": 8635.843719874158}, {"lowerIsBetter": false, "replicates": [1358.714669919317, 1499.1979291079274, 1500.3998400639744, 1672.682190383827, 1789.9642007159848, 7530.849383012336, 7685.807854803633, 7686.385089192865, 7690.423218258632, 7695.422843286755, 7634.274743899321, 7683.500572462786, 7772.494787838787, 7774.727884524043, 7798.376129909608, 1975.2395327798756, 2018.6265540874986, 2211.203966572041, 2302.9654555181687, 2327.499587588668, 2274.3404412720374, 2279.031411650042, 2282.4522114692522, 2283.8058765004994, 2286.371247906822, 2183.465051062492, 2212.7676593957644, 2258.6047441697638, 2258.706368172135, 2260.4461906832767, 2212.811910987552, 2236.7427745809277, 2244.629636110048, 2250.189931624614, 2294.8393612447135, 2244.079927229844, 2253.966190507144, 2263.46808500004, 2265.67147763575, 2272.2388000019846, 7864.410169237273, 7903.960480197562, 7930.524168549906, 7943.205679432069, 7948.046234451903, 4700.29495575663, 4796.856094317176, 4799.0401919616215, 4804.8318308859025, 4806.711597304173, 3053.6793636668053, 3086.7067628575473, 3122.406742718876, 3152.8896488622786, 3158.2735970726862, 996.1084829078007, 1003.6687892995294, 1019.7195771162916, 1022.2026819081128, 1040.0223789637791, 10626.681199563947, 10713.946430267877, 10794.460276986198, 10806.0, 10809.243352965295, 3969.206158768258, 4099.385092236188, 4111.403846442309, 4160.791960401968, 4176.540580536139, 8692.0, 8739.0, 8833.29333653319, 8837.513936733412, 8911.465312081296, 4801.087793319258, 4818.807247710122, 4834.8791280218275, 4835.202191638411, 4835.44392394872, 3838.251540949544, 4310.331898555729, 4374.234508960983, 4377.868663940087, 4391.890202744957, 3533.7526373154146, 3615.5661320641693, 3647.9635203648154, 3656.2321912398693, 3658.1951970566433, 1086.6305456144948, 1101.9669409917715, 1106.1703722208345, 1122.5678113926197, 1126.971825704364, 1241.2366394667215, 1266.379474057705, 1268.8921441677376, 1404.45226361719, 1422.8363738170242, 7519.436042296849, 7609.201033891472, 7718.652660630285, 7733.304002639789, 7734.651940662684, 469.36869909971034, 473.2687997044574, 474.42831388177166, 477.2650118817052, 477.8351468743278, 5832.825015249549, 5855.560832937462, 5889.617174883704, 5938.703064846741, 5944.375840536768, 9187.127222913812, 9803.921568627446, 9805.117539421486, 9809.558569864374, 9951.800963980824, 9639.951800241095, 9648.71053868385, 9709.9029009709, 9743.756406089904, 9769.267304952156, 7305.269473052652, 7500.474966752384, 7515.060617422713, 7586.924130758622, 7598.696052157962, 7266.854662906607, 7349.228331025379, 7354.963225184054, 7368.484206105735, 7391.556506609621, 8587.484750914966, 8664.046954835088, 8670.479771213748, 8780.165884241242, 8824.161704638305, 8177.550234736908, 8968.10318968098, 9066.86664166979, 9119.407238529475, 9135.451872887648, 6099.237595300588, 6224.719887605159, 6654.633995130121, 7017.719291228498, 7119.75080872167, 7432.739854105081, 7467.663955121924, 7473.51422157558, 7490.363319117936, 7512.361449276873, 6685.164354455693, 6868.896966545606, 6889.276625954202, 6995.685194166376, 7065.046218760607, 6879.727250458681, 6912.79261622132, 6974.860502790018, 6999.545029573062, 7000.439964802906, 6930.203026652, 6931.861362772817, 7027.9297207027275, 7118.181409138016, 7169.426445884421, 6615.040819081302, 6623.205215373993, 6656.966715166393, 6671.733130674718, 6672.099266599141, 6517.217933847968, 6712.39588437043, 6733.865322693421, 6748.291429400038, 6749.831254218684], "unit": "score", "name": "mootools.html", "value": 4418.280311222425}, {"lowerIsBetter": false, "replicates": [303.2903006963704, 305.9816411015341, 313.70668425022603, 316.51415077855495, 321.74582080156677, 5965.671888046156, 6010.248718910137, 6027.36712645172, 6030.27636683598, 6042.909356359658, 5930.406959304068, 5951.761929522825, 5965.373635768236, 5968.313643930949, 5969.164316995624, 4280.443542339499, 4425.269830477967, 4515.525869783674, 4525.773711314438, 4533.863984080483, 4490.259107247317, 4522.050369422425, 4528.796204170803, 4530.0, 4530.682852200347, 4306.504751953518, 4479.4176757021705, 4486.170058539181, 4490.550944905516, 4491.865244042668, 4406.977965110186, 4471.776411179428, 4472.8881777955485, 4477.888052798674, 4484.282514797649, 3889.124946886956, 3896.3960586108915, 3897.2205558888336, 3902.3756199008308, 3905.33609286422, 5733.598648094635, 5739.540836733093, 5744.6840423776675, 5744.741486633112, 5755.136729490568, 5169.638125331228, 5178.300929374524, 5179.04187725272, 5180.0, 5182.093133701587, 6210.534209934228, 6211.0, 6222.875542489171, 6224.968875155595, 6231.0, 4082.755034697898, 4199.664026877843, 4200.7479551227025, 4213.641840443566, 4287.742735435884, 6515.4787616991, 6550.820852246594, 6565.048068030157, 6581.769638062693, 6582.670866456658, 4321.481422229353, 4321.913561728811, 4325.870223893288, 4327.285997810326, 4327.82688692455, 4358.56414358568, 4375.474943006796, 4380.912381752347, 4382.671299652475, 4383.868483945423, 5120.155174396183, 5121.847584293579, 5122.052420302256, 5125.666831655931, 5130.4100028497205, 6155.507559395238, 6311.715972781236, 6312.52656050798, 6316.557840951089, 6319.368063193736, 1516.5147152910963, 1516.9165695886832, 1534.6547026918854, 1536.377767004365, 1538.4922975418085, 947.3984020147118, 990.2424645146468, 992.4144754594823, 1004.0060340263233, 1017.9847302290472, 6023.6385816851125, 6027.638341699512, 6061.121137435135, 6076.817695469143, 6077.9392206078255, 6480.708368123445, 6485.513586481033, 6486.870262594722, 6487.837804054936, 6493.026046093124, 6048.395160483917, 6057.8485537861025, 6059.454649081604, 6064.545159112996, 6068.848278793065, 3450.447928331455, 3451.6720911513366, 3467.3065386922717, 3490.7556471046782, 3492.336456073338, 6534.901976470357, 6607.768728094494, 6663.5335526513645, 6667.033225198578, 6678.799636010927, 6571.145751052332, 6586.473082153512, 6590.835229119214, 6591.604503729792, 6596.4393026592315, 6691.356914018936, 6705.195376554747, 6707.5975441473665, 6712.496562757813, 6719.092922455406, 6384.936150638434, 6493.740250389931, 6529.608223506605, 6533.901991470227, 6534.542582019403, 6193.349698281616, 6338.302786693368, 6363.5545511813725, 6368.395002474757, 6369.0, 6691.197056353269, 6700.162479690039, 6707.5975441473665, 6709.899351509829, 6717.529772915849, 4267.722598031118, 4270.807813648331, 4280.807363668705, 4283.914321713611, 4287.656987440935, 6431.389018043278, 6433.228012638513, 6433.646149461637, 6433.871322573429, 6447.258565265054, 6151.6001459904965, 6272.18461599989, 6291.905621415591, 6296.212973378328, 6302.747890084345, 6232.688365581794, 6235.719392627433, 6240.469560087262, 6248.843778905563, 6257.186565746606, 6043.3352331244405, 6067.362926892789, 6068.817935461943, 6074.696265186812, 6079.878402431838, 6247.3440288769025, 6281.7173227203975, 6286.5599408041, 6286.65423401699, 6297.307296197506, 6002.249718785152, 6090.482309003784, 6130.816075517741, 6149.108379285068, 6172.907406388818], "unit": "score", "name": "prototype.html", "value": 4682.709874730102}, {"lowerIsBetter": false, "replicates": [651.7523341130371, 653.5163978655793, 659.518551457436, 662.073097663271, 669.2103318084659, 13993.160410375385, 14236.359363828627, 14264.928675356634, 14303.713925721479, 14347.78478322826, 13023.0, 13160.144590601629, 13175.538856140038, 13180.670483237924, 13226.735465290689, 674.2078058281525, 797.6729540888223, 802.2939812964584, 818.6561644109488, 821.5029906906325, 825.2655136928139, 828.2131974624101, 828.6188353357463, 829.2371018662844, 832.2592892325835, 706.8586282743446, 860.2043110123111, 870.4472659861002, 871.4684042733927, 874.7594411536815, 838.9161083891623, 860.406319639453, 871.5075982070142, 871.930245580352, 872.2760109109456, 637.687533108778, 638.3297537585516, 639.5395315372971, 639.9776007839703, 640.2285246278224, 13411.396487158101, 13484.325783710874, 13487.123336983163, 13498.122622029538, 13502.594922152352, 12639.684007899876, 12925.612231633066, 12964.87035129646, 13071.869281307161, 13125.474981000749, 10579.523921423555, 10656.573737050508, 10732.356058636507, 10832.187585931008, 10875.075618572431, 3854.8458061677497, 3864.768113913146, 3875.4961854958956, 3891.727579069466, 3900.2004589059175, 55048.72475637596, 55886.0, 55929.44070559283, 55939.72030139864, 55945.0, 9260.722178334661, 10161.390316581028, 10276.588936442608, 10526.842097368546, 10745.570177192825, 17012.48962531126, 17226.569335766457, 17227.0, 17242.224099915533, 17249.56876078108, 7739.5743234122665, 7980.201979801974, 8104.189581041848, 8256.669733210605, 8350.749477515685, 4587.770611469413, 4686.086213188463, 4718.386609740712, 4794.832180873653, 4829.637777166727, 3223.7421006319437, 3247.594050743657, 3256.706896379337, 3279.262166012628, 3280.2291461506525, 573.667272981678, 579.3540202673988, 617.4443001298866, 626.151564629929, 638.7668500997103, 594.3759052994338, 608.4706305514231, 610.1086631442492, 632.1497585747163, 659.9274079851212, 8580.613872375758, 8686.0, 8869.201771840566, 8909.910900890907, 9055.003949565542, 565.7171414292853, 571.0777094991558, 618.6999305336908, 633.0472638678851, 633.6293268437923, 4068.816903239361, 4202.222588821078, 4427.889302767457, 4483.574060464251, 4597.540245975376, 57169.714151428976, 59882.401175988554, 59940.0, 60541.394586054455, 60678.696606516685, 51573.96852062938, 51655.74172129115, 51846.74076629593, 53468.0, 53579.46420535823, 51585.0, 52056.73971630118, 53022.99999999923, 53482.0, 54659.72670136624, 9464.19554337889, 9522.238220942447, 9633.373830700983, 9660.565274562801, 9738.415695058318, 38289.0, 40543.59456405398, 41391.0, 41513.37729934114, 42231.577684222764, 43438.782806085765, 46500.767496162305, 48544.75727621339, 50722.492775071776, 53602.46397536131, 10654.0, 11191.216614836883, 11248.437578120898, 11272.774544509228, 11364.829527557258, 11892.524299028288, 12275.0, 12782.872171278168, 12934.159279646792, 13206.27365494907, 11972.940135299268, 12365.0, 12637.684057898627, 12668.366581670694, 12674.809877851656, 11469.0, 11474.368909710047, 11661.416929153678, 11725.179237453638, 11877.940610296893, 11343.376114313793, 11893.94053029764, 12093.516259349528, 12299.815502767287, 12448.377581120727, 10008.64969726056, 10029.749256268651, 10075.899241007495, 10514.842277365999, 10636.468176591294, 10457.215708821717, 10587.364758114538, 10641.255112142077, 10773.838392424277, 10783.676489705322], "unit": "score", "name": "yui.html", "value": 6550.567094090503}], "name": "dromaeo_css", "value": 7001.450170771775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 103.0, 108.0, 109.0, 109.0, 98.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 148.0, 163.0, 131.0, 155.0, 155.0, 125.0, 170.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 163.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 97.0, 100.0, 72.0, 75.0, 74.0, 117.0, 106.0, 75.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 92.0, 102.0, 93.0, 146.0, 91.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 60.0, 66.0, 58.0, 59.0, 68.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.3}, {"lowerIsBetter": true, "replicates": [77.0, 84.0, 78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [112.0, 113.0, 110.0, 109.0, 120.0, 115.0, 123.0, 116.0, 113.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 139.0, 141.0, 142.0, 145.0, 136.0, 142.0, 144.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 66.0, 63.0, 64.0, 62.0, 63.0, 64.0, 63.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1486.0}]} 01:58:57 INFO - Return code: 0 01:58:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:57 ERROR - # TBPL SUCCESS # 01:58:57 INFO - Running post-action listener: _resource_record_post_action 01:58:57 INFO - Running post-run listener: _resource_record_post_run 01:58:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544477184; Read time: 16; Write time: 942956 01:58:58 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 252518400; Read time: 0; Write time: 534436 01:58:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291958784; Read time: 16; Write time: 408520 01:58:58 INFO - Running post-run listener: _upload_blobber_files 01:58:58 INFO - Blob upload gear active. 01:58:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:58:58 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 01:58:58 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'] 01:58:58 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 01:58:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:59 INFO - (blobuploader) - INFO - Done attempting. 01:58:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:59:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:00 INFO - (blobuploader) - INFO - Done attempting. 01:59:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:59:00 INFO - Return code: 0 01:59:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:59:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:59:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8e46f914434c9d2f4d2341ff7677373dde65b78122c05feb094f8aa22cd588f5056941588afdd6adb4674be0a60f7663c0732ffa3457efda175c584c66aaefb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d84bd1e34fdc3d46828355e818e6a755812419511af484b5bd8fefbaab51a6dbaad3da2b22d5188c2821274e6bae83884da01a0ed68f0fa186063176b9103a"} 01:59:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:59:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:59:00 INFO - Contents: 01:59:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8e46f914434c9d2f4d2341ff7677373dde65b78122c05feb094f8aa22cd588f5056941588afdd6adb4674be0a60f7663c0732ffa3457efda175c584c66aaefb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d84bd1e34fdc3d46828355e818e6a755812419511af484b5bd8fefbaab51a6dbaad3da2b22d5188c2821274e6bae83884da01a0ed68f0fa186063176b9103a"} 01:59:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:59:00 INFO - Copying logs to upload dir... 01:59:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:59:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.204701 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-18 01:58:59.415100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 01:58:59.418997) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 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/c8e46f914434c9d2f4d2341ff7677373dde65b78122c05feb094f8aa22cd588f5056941588afdd6adb4674be0a60f7663c0732ffa3457efda175c584c66aaefb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d84bd1e34fdc3d46828355e818e6a755812419511af484b5bd8fefbaab51a6dbaad3da2b22d5188c2821274e6bae83884da01a0ed68f0fa186063176b9103a"} build_url:https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/HX-RacJoRd-2W11IHOjpzg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8e46f914434c9d2f4d2341ff7677373dde65b78122c05feb094f8aa22cd588f5056941588afdd6adb4674be0a60f7663c0732ffa3457efda175c584c66aaefb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d84bd1e34fdc3d46828355e818e6a755812419511af484b5bd8fefbaab51a6dbaad3da2b22d5188c2821274e6bae83884da01a0ed68f0fa186063176b9103a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 01:58:59.443205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:58:59.443491) ========= 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=1861a34ebfea852630dec091000001fa-1458289000.974407-355351161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:58:59.526291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 01:58:59.526588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 01:58:59.526877) ========= ========= Total master_lag: 0.26 =========