builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1458076326.81 results: success (0) buildid: 20160315113028 builduid: 166a5c26ee4d415ab7a4046626456448 revision: 4456c07d6f1f105dbe839dc647da9280d1c5686c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.810454) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.810956) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.811328) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.837473) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.837784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.855025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.855347) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.904920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.905260) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.905661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:06.905983) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 14:12:06-- 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% 50.5M=0s 2016-03-15 14:12:07 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.067573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.067923) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021559 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.118129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.118540) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4456c07d6f1f105dbe839dc647da9280d1c5686c --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 4456c07d6f1f105dbe839dc647da9280d1c5686c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 14:12:07,238 truncating revision to first 12 chars 2016-03-15 14:12:07,238 Setting DEBUG logging. 2016-03-15 14:12:07,238 attempt 1/10 2016-03-15 14:12:07,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4456c07d6f1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 14:12:07,496 unpacking tar archive at: fx-team-4456c07d6f1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.686814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.687211) ========= echo 4456c07d6f1f105dbe839dc647da9280d1c5686c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4456c07d6f1f105dbe839dc647da9280d1c5686c'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4456c07d6f1f105dbe839dc647da9280d1c5686c program finished with exit code 0 elapsedTime=0.003569 script_repo_revision: '4456c07d6f1f105dbe839dc647da9280d1c5686c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.737447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.737808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 14:12:07.747920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-15 14:12:07.748489) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:07 INFO - MultiFileLogger online at 20160315 14:12:07 in /builds/slave/test-pgo 14:12:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:12:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:12:07 INFO - {'append_to_log': False, 14:12:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:12:07 INFO - 'blob_upload_branch': 'Fx-Team', 14:12:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:12:07 INFO - 'branch': 'Fx-Team', 14:12:07 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:07 INFO - 'config_files': ('talos/linux_config.py',), 14:12:07 INFO - 'default_actions': ('clobber', 14:12:07 INFO - 'read-buildbot-config', 14:12:07 INFO - 'download-and-extract', 14:12:07 INFO - 'populate-webroot', 14:12:07 INFO - 'create-virtualenv', 14:12:07 INFO - 'install', 14:12:07 INFO - 'run-tests'), 14:12:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:07 INFO - 'download_minidump_stackwalk': True, 14:12:07 INFO - 'download_symbols': 'ondemand', 14:12:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:07 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:07 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:07 INFO - 'installer_path': 'installer.exe', 14:12:07 INFO - 'log_level': 'info', 14:12:07 INFO - 'log_name': 'talos', 14:12:07 INFO - 'log_to_console': True, 14:12:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:07 INFO - 'opt_config_files': (), 14:12:07 INFO - 'pip_index': False, 14:12:07 INFO - 'sps_profile': False, 14:12:07 INFO - 'sps_profile_interval': 0, 14:12:07 INFO - 'suite': 'dromaeojs', 14:12:07 INFO - 'system_bits': '32', 14:12:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:07 INFO - 'title': 'talos-linux64-ix-045', 14:12:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:07 INFO - 'use_talos_json': True, 14:12:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:12:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:07 INFO - 'work_dir': 'build'} 14:12:07 INFO - ##### 14:12:07 INFO - ##### Running clobber step. 14:12:07 INFO - ##### 14:12:07 INFO - Running pre-action listener: _resource_record_pre_action 14:12:07 INFO - Running main action method: clobber 14:12:07 INFO - rmtree: /builds/slave/test-pgo/build 14:12:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:12:08 INFO - Running post-action listener: _resource_record_post_action 14:12:08 INFO - ##### 14:12:08 INFO - ##### Running read-buildbot-config step. 14:12:08 INFO - ##### 14:12:08 INFO - Running pre-action listener: _resource_record_pre_action 14:12:08 INFO - Running main action method: read_buildbot_config 14:12:08 INFO - Using buildbot properties: 14:12:08 INFO - { 14:12:08 INFO - "project": "", 14:12:08 INFO - "product": "firefox", 14:12:08 INFO - "script_repo_revision": "production", 14:12:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:12:08 INFO - "repository": "", 14:12:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:12:08 INFO - "buildid": "20160315113028", 14:12:08 INFO - "pgo_build": "True", 14:12:08 INFO - "basedir": "/builds/slave/test-pgo", 14:12:08 INFO - "buildnumber": 543, 14:12:08 INFO - "slavename": "talos-linux64-ix-045", 14:12:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:12:08 INFO - "platform": "ubuntu64_hw", 14:12:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:12:08 INFO - "branch": "fx-team", 14:12:08 INFO - "repo_path": "integration/fx-team", 14:12:08 INFO - "revision": "4456c07d6f1f105dbe839dc647da9280d1c5686c", 14:12:08 INFO - "stage_platform": "linux64-pgo", 14:12:08 INFO - "builduid": "166a5c26ee4d415ab7a4046626456448", 14:12:08 INFO - "slavebuilddir": "test" 14:12:08 INFO - } 14:12:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:12:08 INFO - Running post-action listener: _resource_record_post_action 14:12:08 INFO - ##### 14:12:08 INFO - ##### Running download-and-extract step. 14:12:08 INFO - ##### 14:12:08 INFO - Running pre-action listener: _resource_record_pre_action 14:12:08 INFO - Running main action method: download_and_extract 14:12:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:08 INFO - https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:11 INFO - Downloaded 1361 bytes. 14:12:11 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:12:11 INFO - Using the following test package requirements: 14:12:11 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:12:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'jsshell-linux-x86_64.zip'], 14:12:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:11 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:11 INFO - https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:12 INFO - Downloaded 23561931 bytes. 14:12:12 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'] 14:12:12 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 14:12:13 INFO - Return code: 0 14:12:13 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 14:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:13 INFO - https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:14 INFO - Downloaded 23561931 bytes. 14:12:14 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'] 14:12:14 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 14:12:16 INFO - Return code: 0 14:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:16 INFO - https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:17 INFO - Downloaded 10845263 bytes. 14:12:17 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'] 14:12:17 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 14:12:17 INFO - Return code: 0 14:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:17 INFO - https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fZtETBhbTyGNvklezjGNYg/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 14:12:19 INFO - Downloaded 57650597 bytes. 14:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:12:19 INFO - mkdir: /builds/slave/test-pgo/properties 14:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:12:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:12:19 INFO - Contents: 14:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:12:19 INFO - Running post-action listener: _resource_record_post_action 14:12:19 INFO - Running post-action listener: set_extra_try_arguments 14:12:19 INFO - ##### 14:12:19 INFO - ##### Running populate-webroot step. 14:12:19 INFO - ##### 14:12:19 INFO - Running pre-action listener: _resource_record_pre_action 14:12:19 INFO - Running main action method: populate_webroot 14:12:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:19 INFO - '--tppagecycles', 14:12:19 INFO - '7'], 14:12:19 INFO - 'tests': ['tsvgm']}}, 14:12:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:12:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:12:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'tests': ['damp', 'tps']}, 14:12:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['damp', 'tps']}, 14:12:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:12:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:19 INFO - 'other': {'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'other_l64': {'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'other_nol64': {'tests': ['a11yr', 14:12:19 INFO - 'ts_paint', 14:12:19 INFO - 'tpaint', 14:12:19 INFO - 'sessionrestore', 14:12:19 INFO - 'sessionrestore_no_auto_restore', 14:12:19 INFO - 'tabpaint']}, 14:12:19 INFO - 'svgr': {'tests': ['tsvgx', 14:12:19 INFO - 'tsvgr_opacity', 14:12:19 INFO - 'tart', 14:12:19 INFO - 'tscrollx', 14:12:19 INFO - 'cart']}, 14:12:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['tsvgx', 14:12:19 INFO - 'tsvgr_opacity', 14:12:19 INFO - 'tart', 14:12:19 INFO - 'tscrollx', 14:12:19 INFO - 'cart']}, 14:12:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'tests': ['tp5o']}, 14:12:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'talos_options': ['--e10s'], 14:12:19 INFO - 'tests': ['tp5o']}, 14:12:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'talos_options': ['--xperf_path', 14:12:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:19 INFO - 'tests': ['tp5n']}, 14:12:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:19 INFO - 'talos_options': ['--e10s', 14:12:19 INFO - '--xperf_path', 14:12:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:19 INFO - 'tests': ['tp5n']}}, 14:12:19 INFO - 'talos.zip': {'path': '', 14:12:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:19 INFO - Running post-action listener: _resource_record_post_action 14:12:19 INFO - ##### 14:12:19 INFO - ##### Running create-virtualenv step. 14:12:19 INFO - ##### 14:12:19 INFO - Running pre-action listener: _resource_record_pre_action 14:12:19 INFO - Running main action method: create_virtualenv 14:12:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:12:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:12:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:12:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:19 INFO - Using real prefix '/usr' 14:12:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:12:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:22 INFO - Installing pip.................done. 14:12:22 INFO - Return code: 0 14:12:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:22 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:12:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:12:22 INFO - Using env: {'DISPLAY': ':0', 14:12:22 INFO - 'HOME': '/home/cltbld', 14:12:22 INFO - 'LANG': 'en_US.UTF-8', 14:12:22 INFO - 'LANGUAGE': 'en_US:en', 14:12:22 INFO - 'LOGNAME': 'cltbld', 14:12:22 INFO - 'MAIL': '/var/mail/cltbld', 14:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:22 INFO - 'MOZ_NO_REMOTE': '1', 14:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:22 INFO - 'NO_EM_RESTART': '1', 14:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:22 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:22 INFO - 'SHELL': '/bin/bash', 14:12:22 INFO - 'SHLVL': '1', 14:12:22 INFO - 'TERM': 'linux', 14:12:22 INFO - 'TMOUT': '86400', 14:12:22 INFO - 'USER': 'cltbld', 14:12:22 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:22 INFO - '_': '/tools/buildbot/bin/python'} 14:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:12:22 INFO - Cleaning up... 14:12:22 INFO - Return code: 0 14:12:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:22 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:12:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:12:22 INFO - Using env: {'DISPLAY': ':0', 14:12:22 INFO - 'HOME': '/home/cltbld', 14:12:22 INFO - 'LANG': 'en_US.UTF-8', 14:12:22 INFO - 'LANGUAGE': 'en_US:en', 14:12:22 INFO - 'LOGNAME': 'cltbld', 14:12:22 INFO - 'MAIL': '/var/mail/cltbld', 14:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:22 INFO - 'MOZ_NO_REMOTE': '1', 14:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:22 INFO - 'NO_EM_RESTART': '1', 14:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:22 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:22 INFO - 'SHELL': '/bin/bash', 14:12:22 INFO - 'SHLVL': '1', 14:12:22 INFO - 'TERM': 'linux', 14:12:22 INFO - 'TMOUT': '86400', 14:12:22 INFO - 'USER': 'cltbld', 14:12:22 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:22 INFO - '_': '/tools/buildbot/bin/python'} 14:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:22 INFO - Downloading/unpacking psutil>=0.7.1 14:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:24 INFO - Installing collected packages: psutil 14:12:24 INFO - Running setup.py install for psutil 14:12:24 INFO - building 'psutil._psutil_linux' extension 14:12:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:12:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:12:25 INFO - building 'psutil._psutil_posix' extension 14:12:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:12:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:12:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:25 INFO - Successfully installed psutil 14:12:25 INFO - Cleaning up... 14:12:25 INFO - Return code: 0 14:12:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:12:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:12:25 INFO - Using env: {'DISPLAY': ':0', 14:12:25 INFO - 'HOME': '/home/cltbld', 14:12:25 INFO - 'LANG': 'en_US.UTF-8', 14:12:25 INFO - 'LANGUAGE': 'en_US:en', 14:12:25 INFO - 'LOGNAME': 'cltbld', 14:12:25 INFO - 'MAIL': '/var/mail/cltbld', 14:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:25 INFO - 'MOZ_NO_REMOTE': '1', 14:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:25 INFO - 'NO_EM_RESTART': '1', 14:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:25 INFO - 'SHELL': '/bin/bash', 14:12:25 INFO - 'SHLVL': '1', 14:12:25 INFO - 'TERM': 'linux', 14:12:25 INFO - 'TMOUT': '86400', 14:12:25 INFO - 'USER': 'cltbld', 14:12:25 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:25 INFO - '_': '/tools/buildbot/bin/python'} 14:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:12:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:12:27 INFO - Installing collected packages: mozsystemmonitor 14:12:27 INFO - Running setup.py install for mozsystemmonitor 14:12:27 INFO - Successfully installed mozsystemmonitor 14:12:27 INFO - Cleaning up... 14:12:27 INFO - Return code: 0 14:12:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:27 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:12:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:12:27 INFO - Using env: {'DISPLAY': ':0', 14:12:27 INFO - 'HOME': '/home/cltbld', 14:12:27 INFO - 'LANG': 'en_US.UTF-8', 14:12:27 INFO - 'LANGUAGE': 'en_US:en', 14:12:27 INFO - 'LOGNAME': 'cltbld', 14:12:27 INFO - 'MAIL': '/var/mail/cltbld', 14:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:27 INFO - 'MOZ_NO_REMOTE': '1', 14:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:27 INFO - 'NO_EM_RESTART': '1', 14:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:27 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:27 INFO - 'SHELL': '/bin/bash', 14:12:27 INFO - 'SHLVL': '1', 14:12:27 INFO - 'TERM': 'linux', 14:12:27 INFO - 'TMOUT': '86400', 14:12:27 INFO - 'USER': 'cltbld', 14:12:27 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:27 INFO - '_': '/tools/buildbot/bin/python'} 14:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:27 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:12:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:12:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:12:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:30 INFO - Downloading docopt-0.6.1.tar.gz 14:12:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:12:30 INFO - Installing collected packages: blobuploader, requests, docopt 14:12:30 INFO - Running setup.py install for blobuploader 14:12:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:12:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:12:30 INFO - Running setup.py install for requests 14:12:30 INFO - Running setup.py install for docopt 14:12:30 INFO - Successfully installed blobuploader requests docopt 14:12:30 INFO - Cleaning up... 14:12:31 INFO - Return code: 0 14:12:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:31 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:31 INFO - Using env: {'DISPLAY': ':0', 14:12:31 INFO - 'HOME': '/home/cltbld', 14:12:31 INFO - 'LANG': 'en_US.UTF-8', 14:12:31 INFO - 'LANGUAGE': 'en_US:en', 14:12:31 INFO - 'LOGNAME': 'cltbld', 14:12:31 INFO - 'MAIL': '/var/mail/cltbld', 14:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:31 INFO - 'MOZ_NO_REMOTE': '1', 14:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:31 INFO - 'NO_EM_RESTART': '1', 14:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:31 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:31 INFO - 'SHELL': '/bin/bash', 14:12:31 INFO - 'SHLVL': '1', 14:12:31 INFO - 'TERM': 'linux', 14:12:31 INFO - 'TMOUT': '86400', 14:12:31 INFO - 'USER': 'cltbld', 14:12:31 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:31 INFO - '_': '/tools/buildbot/bin/python'} 14:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:12:31 INFO - Running setup.py (path:/tmp/pip-PyH4bS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:12:31 INFO - Running setup.py (path:/tmp/pip-yf0rSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:12:31 INFO - Running setup.py (path:/tmp/pip-c0S49U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:12:31 INFO - Running setup.py (path:/tmp/pip-eaVlWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:12:31 INFO - Running setup.py (path:/tmp/pip-wEK6Z8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:12:31 INFO - Running setup.py (path:/tmp/pip-iR8C3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:12:31 INFO - Running setup.py (path:/tmp/pip-qdvksi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:12:31 INFO - Running setup.py (path:/tmp/pip-tBr6ps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:12:31 INFO - Running setup.py (path:/tmp/pip-oWjRJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:12:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:12:31 INFO - Running setup.py (path:/tmp/pip-OFJSH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:12:32 INFO - Running setup.py (path:/tmp/pip-VjzaSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:12:32 INFO - Running setup.py (path:/tmp/pip-54DSGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:12:32 INFO - Running setup.py (path:/tmp/pip-8bp82g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:12:32 INFO - Running setup.py (path:/tmp/pip-MXap3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:12:32 INFO - Running setup.py (path:/tmp/pip-NWHoOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:12:32 INFO - Running setup.py (path:/tmp/pip-Wv753Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:12:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:12:32 INFO - Running setup.py (path:/tmp/pip-rlfvU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:12:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:12:32 INFO - Running setup.py install for manifestparser 14:12:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:12:32 INFO - Running setup.py install for mozcrash 14:12:32 INFO - Running setup.py install for mozdebug 14:12:32 INFO - Running setup.py install for mozdevice 14:12:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:12:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:12:32 INFO - Running setup.py install for mozfile 14:12:33 INFO - Running setup.py install for mozhttpd 14:12:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozinfo 14:12:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozInstall 14:12:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozleak 14:12:33 INFO - Running setup.py install for mozlog 14:12:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for moznetwork 14:12:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozprocess 14:12:33 INFO - Running setup.py install for mozprofile 14:12:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozrunner 14:12:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:12:33 INFO - Running setup.py install for mozscreenshot 14:12:34 INFO - Running setup.py install for moztest 14:12:34 INFO - Running setup.py install for mozversion 14:12:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:12:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:34 INFO - Cleaning up... 14:12:34 INFO - Return code: 0 14:12:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:34 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:12:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:34 INFO - Using env: {'DISPLAY': ':0', 14:12:34 INFO - 'HOME': '/home/cltbld', 14:12:34 INFO - 'LANG': 'en_US.UTF-8', 14:12:34 INFO - 'LANGUAGE': 'en_US:en', 14:12:34 INFO - 'LOGNAME': 'cltbld', 14:12:34 INFO - 'MAIL': '/var/mail/cltbld', 14:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:34 INFO - 'MOZ_NO_REMOTE': '1', 14:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:34 INFO - 'NO_EM_RESTART': '1', 14:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:34 INFO - 'SHELL': '/bin/bash', 14:12:34 INFO - 'SHLVL': '1', 14:12:34 INFO - 'TERM': 'linux', 14:12:34 INFO - 'TMOUT': '86400', 14:12:34 INFO - 'USER': 'cltbld', 14:12:34 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:34 INFO - '_': '/tools/buildbot/bin/python'} 14:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:12:34 INFO - Running setup.py (path:/tmp/pip-Lcyb9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:12:34 INFO - Running setup.py (path:/tmp/pip-VZ2KWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:12:34 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)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:12:34 INFO - Running setup.py (path:/tmp/pip-UdLCT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:12:34 INFO - Running setup.py (path:/tmp/pip-EZg0nP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:12:34 INFO - Running setup.py (path:/tmp/pip-z4HmUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:12:34 INFO - Running setup.py (path:/tmp/pip-t8LD62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:12:34 INFO - Running setup.py (path:/tmp/pip-bXP3hI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:12:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:12:34 INFO - Running setup.py (path:/tmp/pip-IcaVEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:12:35 INFO - Running setup.py (path:/tmp/pip-Gf9_A1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:12:35 INFO - Running setup.py (path:/tmp/pip-zgC1cb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:12:35 INFO - Running setup.py (path:/tmp/pip-FxNqVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:12:35 INFO - Running setup.py (path:/tmp/pip-EaQMXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:12:35 INFO - Running setup.py (path:/tmp/pip-Cmc2zI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:12:35 INFO - Running setup.py (path:/tmp/pip-HJypF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:12:35 INFO - Running setup.py (path:/tmp/pip-Atf6Cy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:12:35 INFO - Running setup.py (path:/tmp/pip-tQdEAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:12:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:12:35 INFO - Running setup.py (path:/tmp/pip-pE5io0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:12:35 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)) 14:12:35 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)) 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:37 INFO - Downloading blessings-1.6.tar.gz 14:12:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:37 INFO - Installing collected packages: blessings 14:12:37 INFO - Running setup.py install for blessings 14:12:37 INFO - Successfully installed blessings 14:12:37 INFO - Cleaning up... 14:12:37 INFO - Return code: 0 14:12:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:12:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:12:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:12:38 INFO - Reading from file tmpfile_stdout 14:12:38 INFO - Current package versions: 14:12:38 INFO - argparse == 1.2.1 14:12:38 INFO - blessings == 1.6 14:12:38 INFO - blobuploader == 1.2.4 14:12:38 INFO - docopt == 0.6.1 14:12:38 INFO - manifestparser == 1.1 14:12:38 INFO - mozInstall == 1.12 14:12:38 INFO - mozcrash == 0.17 14:12:38 INFO - mozdebug == 0.1 14:12:38 INFO - mozdevice == 0.48 14:12:38 INFO - mozfile == 1.2 14:12:38 INFO - mozhttpd == 0.7 14:12:38 INFO - mozinfo == 0.9 14:12:38 INFO - mozleak == 0.1 14:12:38 INFO - mozlog == 3.1 14:12:38 INFO - moznetwork == 0.27 14:12:38 INFO - mozprocess == 0.22 14:12:38 INFO - mozprofile == 0.28 14:12:38 INFO - mozrunner == 6.11 14:12:38 INFO - mozscreenshot == 0.1 14:12:38 INFO - mozsystemmonitor == 0.0 14:12:38 INFO - moztest == 0.7 14:12:38 INFO - mozversion == 1.4 14:12:38 INFO - psutil == 3.1.1 14:12:38 INFO - requests == 1.2.3 14:12:38 INFO - wsgiref == 0.1.2 14:12:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:38 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 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:12:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:38 INFO - Using env: {'DISPLAY': ':0', 14:12:38 INFO - 'HOME': '/home/cltbld', 14:12:38 INFO - 'LANG': 'en_US.UTF-8', 14:12:38 INFO - 'LANGUAGE': 'en_US:en', 14:12:38 INFO - 'LOGNAME': 'cltbld', 14:12:38 INFO - 'MAIL': '/var/mail/cltbld', 14:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:38 INFO - 'MOZ_NO_REMOTE': '1', 14:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:38 INFO - 'NO_EM_RESTART': '1', 14:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:38 INFO - 'SHELL': '/bin/bash', 14:12:38 INFO - 'SHLVL': '1', 14:12:38 INFO - 'TERM': 'linux', 14:12:38 INFO - 'TMOUT': '86400', 14:12:38 INFO - 'USER': 'cltbld', 14:12:38 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:38 INFO - '_': '/tools/buildbot/bin/python'} 14:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:12:38 INFO - Cleaning up... 14:12:38 INFO - Return code: 0 14:12:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:12:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:12:38 INFO - Using env: {'DISPLAY': ':0', 14:12:38 INFO - 'HOME': '/home/cltbld', 14:12:38 INFO - 'LANG': 'en_US.UTF-8', 14:12:38 INFO - 'LANGUAGE': 'en_US:en', 14:12:38 INFO - 'LOGNAME': 'cltbld', 14:12:38 INFO - 'MAIL': '/var/mail/cltbld', 14:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:38 INFO - 'MOZ_NO_REMOTE': '1', 14:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:38 INFO - 'NO_EM_RESTART': '1', 14:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:38 INFO - 'SHELL': '/bin/bash', 14:12:38 INFO - 'SHLVL': '1', 14:12:38 INFO - 'TERM': 'linux', 14:12:38 INFO - 'TMOUT': '86400', 14:12:38 INFO - 'USER': 'cltbld', 14:12:38 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:38 INFO - '_': '/tools/buildbot/bin/python'} 14:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:38 INFO - Downloading/unpacking jsonschema 14:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:12:40 INFO - Downloading/unpacking functools32 (from jsonschema) 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:12:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:12:40 INFO - warning: no files found matching '*.txt' 14:12:40 INFO - no previously-included directories found matching 'build' 14:12:40 INFO - no previously-included directories found matching 'dist' 14:12:40 INFO - no previously-included directories found matching '.git*' 14:12:40 INFO - Installing collected packages: jsonschema, functools32 14:12:40 INFO - Running setup.py install for functools32 14:12:40 INFO - warning: no files found matching '*.txt' 14:12:40 INFO - no previously-included directories found matching 'build' 14:12:40 INFO - no previously-included directories found matching 'dist' 14:12:40 INFO - no previously-included directories found matching '.git*' 14:12:40 INFO - Successfully installed jsonschema functools32 14:12:40 INFO - Cleaning up... 14:12:40 INFO - Return code: 0 14:12:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:12: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')]} 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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')]} 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c20b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:12:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:12:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:12:40 INFO - Using env: {'DISPLAY': ':0', 14:12:40 INFO - 'HOME': '/home/cltbld', 14:12:40 INFO - 'LANG': 'en_US.UTF-8', 14:12:40 INFO - 'LANGUAGE': 'en_US:en', 14:12:40 INFO - 'LOGNAME': 'cltbld', 14:12:40 INFO - 'MAIL': '/var/mail/cltbld', 14:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:40 INFO - 'MOZ_NO_REMOTE': '1', 14:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:40 INFO - 'NO_EM_RESTART': '1', 14:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:40 INFO - 'SHELL': '/bin/bash', 14:12:40 INFO - 'SHLVL': '1', 14:12:40 INFO - 'TERM': 'linux', 14:12:40 INFO - 'TMOUT': '86400', 14:12:40 INFO - 'USER': 'cltbld', 14:12:40 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:40 INFO - '_': '/tools/buildbot/bin/python'} 14:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:40 INFO - Downloading/unpacking flake8 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:12:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:12:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:12:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:43 INFO - no previously-included directories found matching 'docs/_build' 14:12:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:12:43 INFO - Running setup.py install for pep8 14:12:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:43 INFO - no previously-included directories found matching 'docs/_build' 14:12:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:12:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:12:43 INFO - Cleaning up... 14:12:43 INFO - Return code: 0 14:12:43 INFO - Running post-action listener: _resource_record_post_action 14:12:43 INFO - Running post-action listener: _start_resource_monitoring 14:12:43 INFO - Starting resource monitoring. 14:12:43 INFO - ##### 14:12:43 INFO - ##### Running install step. 14:12:43 INFO - ##### 14:12:43 INFO - Running pre-action listener: _resource_record_pre_action 14:12:43 INFO - Running main action method: install 14:12:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:12:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:12:44 INFO - Reading from file tmpfile_stdout 14:12:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:12:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:12:44 INFO - Reading from file tmpfile_stdout 14:12:44 INFO - Output received: 14:12:44 INFO - Usage: mozinstall [options] installer 14:12:44 INFO - Options: 14:12:44 INFO - -h, --help show this help message and exit 14:12:44 INFO - -d DEST, --destination=DEST 14:12:44 INFO - Directory to install application into. [default: 14:12:44 INFO - "/builds/slave/test-pgo"] 14:12:44 INFO - --app=APP Application being installed. [default: firefox] 14:12:44 INFO - mkdir: /builds/slave/test-pgo/build/application 14:12:44 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'] 14:12:44 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 14:13:00 INFO - Reading from file tmpfile_stdout 14:13:00 INFO - Output received: 14:13:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:13:00 INFO - Running post-action listener: _resource_record_post_action 14:13:00 INFO - ##### 14:13:00 INFO - ##### Running run-tests step. 14:13:00 INFO - ##### 14:13:00 INFO - Running pre-action listener: _resource_record_pre_action 14:13:00 INFO - Running main action method: run_tests 14:13:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:13:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:13:00 INFO - Python 2.7.3 14:13:00 INFO - Return code: 0 14:13:00 INFO - grabbing minidump binary from tooltool 14:13: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')]} 14:13:00 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 0x1709920>, '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 0x170a820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x170acb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:13:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:13:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:13:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:00 INFO - Return code: 0 14:13:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:13:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:13:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:13:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:13:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:13:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:13:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:13:01 INFO - Return code: 0 14:13:01 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/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:13:01 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/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:13:01 INFO - Using env: {'DISPLAY': ':0', 14:13:01 INFO - 'HOME': '/home/cltbld', 14:13:01 INFO - 'LANG': 'en_US.UTF-8', 14:13:01 INFO - 'LANGUAGE': 'en_US:en', 14:13:01 INFO - 'LOGNAME': 'cltbld', 14:13:01 INFO - 'MAIL': '/var/mail/cltbld', 14:13:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:13:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:01 INFO - 'MOZ_NO_REMOTE': '1', 14:13:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:01 INFO - 'NO_EM_RESTART': '1', 14:13:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:13:01 INFO - 'SHELL': '/bin/bash', 14:13:01 INFO - 'SHLVL': '1', 14:13:01 INFO - 'TERM': 'linux', 14:13:01 INFO - 'TMOUT': '86400', 14:13:01 INFO - 'USER': 'cltbld', 14:13:01 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383', 14:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:01 INFO - '_': '/tools/buildbot/bin/python'} 14:13:01 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/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:13:01 INFO - mozversion application_buildid: 20160315113028 14:13:01 INFO - mozversion application_changeset: 4456c07d6f1f105dbe839dc647da9280d1c5686c 14:13:01 INFO - mozversion application_display_name: Nightly 14:13:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:01 INFO - mozversion application_name: Firefox 14:13:01 INFO - mozversion application_remotingname: firefox 14:13:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:13:01 INFO - mozversion application_vendor: Mozilla 14:13:01 INFO - mozversion application_version: 48.0a1 14:13:01 INFO - mozversion platform_buildid: 20160315113028 14:13:01 INFO - mozversion platform_changeset: 4456c07d6f1f105dbe839dc647da9280d1c5686c 14:13:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:13:01 INFO - mozversion platform_version: 48.0a1 14:13:01 INFO - using testdate: 1458076381 14:13:01 INFO - actual date: 1458076381 14:13:01 INFO - starting webserver on 'localhost:52996' 14:13:01 INFO - SUITE-START | Running 2 tests 14:13:01 INFO - TEST-START | dromaeo_css 14:13:01 INFO - operating with platform_type : linux_ 14:13:01 INFO - Initialising browser for dromaeo_css test... 14:13:01 INFO - TEST-INFO | started process 30777 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKylk_N/profile http://localhost:52996/getInfo.html) 14:13:05 INFO - PROCESS | 30777 | __metrics Screen width/height:1600/1200 14:13:05 INFO - PROCESS | 30777 | colorDepth:24 14:13:05 INFO - PROCESS | 30777 | Browser inner width/height: 1024/697 14:13:05 INFO - PROCESS | 30777 | __metrics 14:13:06 ERROR - PROCESS | 30777 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:13:07 INFO - TEST-INFO | 30777: exit 0 14:13:07 INFO - Browser initialized. 14:13:07 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:07 INFO - TEST-INFO | started process 30868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKylk_N/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:19 INFO - PROCESS | 30868 | RSS: Main: 152301568 14:13:19 INFO - PROCESS | 30868 | 14:14:09 INFO - PROCESS | 30868 | 1458076449890 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:16:17 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52996/tests/dromaeo/cssquery-ext.html) 14:16:18 INFO - PROCESS | 30868 | RSS: Main: 256651264 14:16:18 INFO - PROCESS | 30868 | 14:19:20 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-ext.html (next: http://localhost:52996/tests/dromaeo/cssquery-jquery.html) 14:19:21 INFO - PROCESS | 30868 | RSS: Main: 234180608 14:19:21 INFO - PROCESS | 30868 | 14:22:22 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52996/tests/dromaeo/cssquery-mootools.html) 14:22:23 INFO - PROCESS | 30868 | RSS: Main: 230051840 14:22:23 INFO - PROCESS | 30868 | 14:25:25 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52996/tests/dromaeo/cssquery-prototype.html) 14:25:25 INFO - PROCESS | 30868 | RSS: Main: 221159424 14:25:25 INFO - PROCESS | 30868 | 14:28:28 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52996/tests/dromaeo/cssquery-yui.html) 14:28:28 INFO - PROCESS | 30868 | RSS: Main: 219033600 14:28:28 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | Cycle 1(1): loaded http://localhost:52996/tests/dromaeo/cssquery-yui.html (next: http://localhost:52996/tests/dromaeo/cssquery-dojo.html) 14:31:31 INFO - PROCESS | 30868 | RSS: Main: 267456512 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | __start_tp_report 14:31:31 INFO - PROCESS | 30868 | _x_x_mozilla_page_load 14:31:31 INFO - PROCESS | 30868 | _x_x_mozilla_page_load_details 14:31:31 INFO - PROCESS | 30868 | |i|pagename|runs| 14:31:31 INFO - PROCESS | 30868 | |0;dojo.html;3039.8480075996195;3059.1893148315685;3099.333643266699;3102.6431960324553;3130.0766273949184;5215.6349055566125;5242.554382877455;5245.973770131149;5272.973635131823;5285.656432331895;5359.062164121273;5374.543163831069;5388.515033646971;5400.486953739389;5431.646942948705;4793.5685788279225;4796.08874313881;4816.97591512042;4829.3480380148585;4962.379702537183;4882.121218180726;4888.853334399973;4891.192953162724;4944.456109827934;4967.826126085588;4765.046990601893;4862.29496722975;4902.338184345103;4914.04176185644;4957.7769000395065;4851.733154676492;4863.513648635144;4864.902701945976;4875.049365373754;4884.413870335547;4764.904701905977;4835.709857408567;4835.806567737286;4842.975785121052;4892.633052521075;5191.091558977164;5229.660072095302;5233.895322093575;5235.1623740201385;5261.473852614746;5689;5707.229524014288;5711.114777209539;5711.971440142815;5713.000224960615;5612.663240205601;5639.436056394369;5725.799597014126;5733.856653583652;5734.283214598176;5353.38436079848;5361.624686271963;5362.544183744387;5363.088274993222;5363.436839131913;5858.209141765892;5860.2967643883;5860.648361098262;5861.17943487912;5863.560232982543;5512.173174023848;5619.831405057855;5629.352624448241;5638.464345887134;5693.886122277614;5714.285714285715;5721.885562288731;5727.914081288784;5730.36965933747;5741.62679425836;5665.178549110356;5671;5676.829695109153;5684.516816070598;5687.374388817227;5541.307336582927;5648.971755141198;5677.347105082886;5699.316082070095;5759.942400576025;4338.089001309697;4341.305391137403;4345.782710864444;4348.260795664744;4377.6497880170145;3869.5936926622862;3876.282887665791;3882.650561449483;3894.9805250973563;3912.5109361329833;5239.476052394806;5386.434424385461;5415.783368665288;5466.6993315367245;5468.316460442445;5702.230198923092;5723.170140329629;5723.313202415654;5743.167240750151;5755.913661295084;5286.8942621148135;5359.812406565751;5384.273123128406;5384.784608615611;5419.024575576355;4864.489228630943;4890.535399137077;4896.559309662148;4929.704217746947;4929.802807887644;5857;5882.088276317178;5900.1739756434135;5901.940980590139;5902.763889444374;5605.271314729059;5702.515286200636;5703.287089113861;5707.086866101404;5757.395473475225;5904.527637789052;5917.970410147922;5920.555958303231;5924;5924.644521328734;5627.409122042127;5630.774769009194;5643.407442218508;5647.604667673223;5651.660900345993;5567.220589117445;5701.486866182064;5715.228444159985;5736.311642602915;5783.508401785895;5622.971885140548;5625.606207565431;5626.88746225065;5632.605717599728;5638.746256418389;5559.249501317432;5579.2746942897165;5585.581081418991;5587.55299576041;5589.329280486368;5387.299651045339;5428.294321738149;5470.890582188414;5496.422875598165;5549.084401073777;5547.667139971614;5598.804041858678;5620.1569764534015;5621.803236886853;5622.606417550732;5482.205080263419;5520.089185284543;5521.1442226454965;5521.3926468089285;5522.171674248895 14:31:31 INFO - PROCESS | 30868 | |1;ext.html;553.3581045986656;556.6882545774364;576.4696479239101;603.4689473263527;638.7157714816902;29543.55684664729;38122.42816357753;38589.614103858956;38598.807005965;38673;41498.265156135945;42121.36817947726;42144.57855421445;42163.367549486786;42222.788886055525;7954.880676789853;8650.826983460327;8853.335999800009;10090.192784577253;10263.384196948207;10208.387496750182;10378.532966016548;10382.532786024647;10383.792324153512;10391.584336626564;10306.793864122714;10410.583576656925;10415.166786657088;10417.114545263661;10419.166466682647;10213.438260895648;10344.172466202686;10374.221933354991;10381.740456488647;10383.636572719955;10486.685399437953;10619.41593212373;10638.73403164927;10643.893561064368;10650.680479585548;41582.58417415847;41629;41741;41844.581554184675;41964.37053444201;3615.6745892869503;3701.777893326382;3802.524684414448;4197.97901010493;4388.692791504596;30303.242418939484;32558.511622325685;32659.510107348407;32767.344653106804;33898.83050584756;4353.28170851809;4368.694191406603;4372.656532485344;4417.09449562842;4423.270160423526;312419;313408;313662;313834;313874;47110.76444617823;64078;64370;64377.356226438074;64461;45219.547804521535;45276.3208551872;45385.2345503724;45482.31776523355;45490.31764523535;15584.298706558006;15872.127033013065;15876.603084922739;15892.125933073792;15901;12539.059570532247;12575.056870734732;12596.81104783429;12599.433025513874;12613.621591352274;15533.145676987648;15547.922260388852;15823.920880395755;15825.762613560575;15844.52466426009;6211.9689401552705;6299.874002519924;6352.555321127569;6370.904436433457;6424.229092508929;977.6578197630914;1025.733309339577;1112.9888701113048;1121.3664279681955;1266.2022925557023;32716.672833271838;32898.50652240218;32979.83510082434;33064.33871322608;33390.49914251288;1083.707399002265;1115.7991561519004;1118.0999295567146;1124.7244425115898;1219.0491416694992;16277.674446511004;16991.49025529236;17034.91482542604;17112.828871711372;17122.229499672543;400709;401859;404148;405276;405563;56964.71517642468;57485.42514574884;57521.71239143777;57603.711981439825;57633.711831440574;1227.7851376009162;1239.3555351217317;1284.4862055177816;1349.413005342679;1417.5392997275721;28663.856680716464;29704.554431683973;30536.389272214874;32031.519527206645;32169;44803;45127.32309015302;45152;45187.774061130796;45232.77383613193;189925;189932;190008;190320;190511;31177.220569485944;35059.474107887894;35255.82372088123;35370.46944295889;35691.821540893165;48435.5156448431;48497;49126.5087349122;49255.753721231165;49865;35696.821515892254;36135.63864361428;36309.27381452303;36714;38347.2330553393;38385.808070959465;38864.02839928911;39329.803350983064;39746.60253397429;40579.79710101431;40540;40924.79537602412;41104.58895411008;41191.588084118775;41612.58387416087;34848.65151348454;35402.82298588491;35993.46009809907;36059.81970090133;36178;27794;28009.43981120407;28019.85990070118;28050.719492805627;28063.158105256876 14:31:31 INFO - PROCESS | 30868 | |2;jquery.html;378.5079396784181;381.9446180303856;381.9503464549608;384.1241968312249;384.49438987731133;17538.82461175388;18291.63416731666;19077.85532868029;19095.331663391786;19124.808751912493;19380.321688740896;19386.4184074478;19473.610527789435;20096.88982656822;20099.789023207435;6150;6288.496920246369;6305.716242769086;6327.335629758878;6331.176946996907;4506.8422605208825;5572.219889215513;6891.173059232874;7174.426045916341;7189.281071892821;6994.230634630212;7042.330978557029;7047.365737083662;7077.186123595775;7091.71633134674;6851.3491218334175;7012.859742805115;7020.7191712331705;7027.789166324993;7040.964795176017;4350.978245108786;4497.078098989699;6517.608943463408;6738.326167383271;6743.460523158135;22790.202342918084;23261.185858495042;24003.27990160298;24902.37744056395;24933.376665583324;2254.1997590855176;2292.1633603734685;2410.288964755401;2669.479451506957;2683.771879390254;14489.492867749577;14553.126812391185;14745;14853.108813471119;15269.236538173158;2083.8853863037525;2127.2660931978444;2141.0365335598885;2185.136870935987;2275.988620056906;76715;82659;86002.13997860067;86782.56608716917;86794;17753;17957.551061223312;18050.1877415514;18075;18183.45449636513;27449.17652470429;27499.17502474929;27803.58294625582;27839.721602783713;27879.303017424725;9506.667266645634;9635.807283854283;9851.950740246397;10008.299419040743;10061;8456.492610443393;8519.06290308078;8551.700690475804;8624.310055195569;8641.092685267957;8867.68963086289;8875.600597973107;8919.770057485628;8934.86597701035;8997.820043599091;3181.0933883842995;3215.7748957573212;3249;3317.4857897025518;3410.215650400422;952.3999880075509;1025.123519390925;1035.5805898611075;1062.6652604429735;1119.3451830679144;17291.82708172902;17955.820441795677;18044.819551804576;18252.54368640768;18596.907015464836;951.9714408567754;997.8973234575834;1006.4866917871938;1040.625374865048;1055.4617145255975;9844.015598440099;10224.182065434747;10249.590016399261;10420.759536699647;10466.11038061758;450700;452048;462233;465004;465278;80996.16513422002;82037;83663.16336836676;83890;83940;1083.4420273559124;1097.2703152403562;1121.545773961547;1123.07346439188;1125.662301309604;15656.13891235993;15811.367545298059;15866.44467443634;15874;15925;37276;37442.25115497729;37773.24453510969;38322.80838595789;38695.80652096721;51497.22754158766;55481.72259138679;55499;55645.72177139088;55834.391465621404;7997.92002079995;8201.42590018693;8205.83588328242;8289.171082891662;8302.294304984143;9659.71020869375;11764.88235117672;12600.621981340575;12872.292023938773;12931.418086185957;10697.251192416456;10900;11254.549818007188;11257.493412796608;11391.373474458984;11027.669169924915;11162.55349786032;11740.706482337668;11959.76080478403;11995.980341671057;11814.291142531476;12283.631491055283;12381.442835072263;12431;12454.501819927464;8286.212809783061;8343.499390036617;8448.704295349633;8649.56752162402;8663.090375510481;10306.587736490457;11933.52265909354;11990.940045300067;12118.575849845212;12242 14:31:31 INFO - PROCESS | 30868 | |3;mootools.html;1446.5804916574193;1551.0771091200736;1552.9611759706006;1746.4673274651227;1885.59459716161;7863.449558530905;8042.51744895306;8044.396670249733;8063.475874068182;8071;7853.764387068397;8041.236082572161;8056.436049476539;8062.113167551579;8062.435629505937;2055.332017094443;2355.3640517060385;2362.787349138577;2393.6768536247646;2398.8440751351195;2408.397900524869;2417.9637305440433;2419.41933935855;2419.7822196002357;2420.298113547069;2312.6646636237733;2418.3349578865777;2418.903243870243;2419.733829278778;2421.092090466075;2361.327021798788;2381.6070348392495;2444.340028192378;2445.4986727720775;2446.1683027770555;2388.79695225906;2393.8084953203875;2402.9519409611885;2431.8297719159664;2433.7809597136343;8202.097769245378;8247.463914845515;8262.462939908946;8262.958685206535;8263.049749278789;5214.60890433219;5326.98787230425;5328.5470734987575;5330.813421530228;5332.120200166968;3471.698113207547;3535.7878527288444;3589.1206654369585;3596.1908570571672;3612.223371975038;1134.9432528373547;1143.9656810295705;1168.8772678868681;1195.0141133564757;1209.6552482542522;11329.376884271443;11420.257683250646;11431.08551315901;11432.256903301259;11472.71318217043;4702.130105930414;4735.289706544046;4796.712197268175;4823.589994850477;4830.686005409708;9776.51117444125;9784.461854598065;9788.461634610023;9789.265805064648;9796.16732577739;4690.859274221779;5285.841424757264;5287.814926477632;5294.047071527162;5299.973500132474;4692.0850434165695;4739.644526660514;4780.235162374073;4808.855734327975;4816.277558366273;3891.7081218908697;3968.146848427602;3998.7000974926414;3999.420084087791;4030.0730831908827;1267.0560432477862;1279.1365828066018;1286.9678258043623;1291.8966482681362;1300.6163181861373;1386.1890793885489;1398.4965412451509;1421.6943357178257;1456.4174330267765;1465.1648560320727;7921.287084162453;7995.40034497415;7999.3200577950365;8010.239027292398;8020;499.67521111277233;499.6827014845599;501.6187697349967;1242.515418986596;1317.0517227596115;6208.658523781235;6212.223472065992;6274.435300822948;6290.402411770874;6298.559100862895;9604.135627793392;9981.201503879673;9995.800083998425;9996.300258981946;10036.749081273027;9475.241980641533;9572.56923438447;9594.760130996641;9940.602375905028;9944.900550994542;7724.575148366781;7787.143414224431;7850.136484986647;7873.763787086511;7921.207879212033;7750.263724946121;7798.025246844145;7882.763517094496;7893.447458677838;7918.920810791818;8710.564471776512;9018.278537717099;9089.31830112731;9157;9209.76975575616;9199.678011269574;9397.671081512115;9408.341416100808;9548.188403985461;9577.856332155163;6570.244421891352;6820.829479263058;6970.477214209056;7308.671109799965;7404.740834070997;7832.647530861011;7862.60686965638;7874.56689882062;7899.210078992055;7901.68393264263;7137.785866424016;7265.891011634724;7272.527285726411;7365.852682946418;7406.666699998405;7271.3455788979245;7281.927180728337;7302.123745150616;7312.049433573601;7375.704971801068;7455.552666840007;7541.962290188514;7581.810454738676;7589.051368578927;7593;6869.175698916162;6875.519270856558;6928.584284942919;6933.583984960918;6943.166819981635;7029.0862187915245;7088.539244949062;7095.361417472453;7101.289871013064;7103.112110986127 14:31:31 INFO - PROCESS | 30868 | |4;prototype.html;348.1036331446526;349.24911440403133;349.6486031538304;349.8460677301987;350.80355001199337;6006.489448396892;6045.939540604592;6059.484943779778;6077.939220607793;6083.847903802407;5953.910691339634;5963.105534169877;5972.044472884329;6058;6063.6968151592355;4480.350349199364;4557.111363284161;4663.4637016743;4690.296455531663;4718.19790635591;4688.523115218695;4691.671582989192;4700.905981880361;4705.576498115169;4713.740744259065;4638.976805115986;4648.442186937556;4654.627629789608;4660.930086048712;4661.953380466202;4440.600345968862;4549.545045495441;4628.907421851578;4639.095376401603;4641.628669706415;4066.9389959150635;4076.7757773322455;4077.4495443115097;4082.7142100053006;4097.631213190827;5756.7985120521;5786.334571524287;5791.7837254176675;5798.884022319572;5807;5385.919211211835;5399.595030372699;5411.458854114597;5412.91880621791;5416.972915135439;6313.558050936436;6323.336049714806;6333.24001119864;6335.3981371769605;6341.1756471658855;4284.378765079077;4391.6047555719815;4414.6688998324935;4423.955760442386;4537.77311134442;6600.537962342638;6666.899996500057;6680.465562754968;6688.130543029423;6691.464682825363;4476.149531588988;4510.977445112819;4515.593596576324;4518.593326600556;4522.412086428743;4572.634189264851;4576.633869290449;4577.176108300538;4578.450585929643;4581.473130589959;5317.335333083364;5318.9202161967605;5320.095583750772;5321.574274058066;5330.466953304638;6305.795240796625;6409.871802563923;6451.967740161269;6453.967730161413;6457.2574153971955;1583.8732901367862;1598.7521934100232;1606.7348887433677;1609.7424412094008;1611.4440518021263;1003.7390278527636;1027.897210278981;1047.586203449633;1058.0636137018794;1069.1340014588052;5992.250968628921;6002.339742628307;6006.429389208019;6007.519398448114;6013.909791353133;6366.77716279928;6487.35126487357;6492.837679058061;6498.805035848932;6501.902471462932;6063.787767428207;6064.4541991221;6065.090236464565;6066.332703402622;6076.665783381956;3465.3935561276676;3498.160441494074;3503.789772613651;3506.7019303359502;3506.7194624429985;6543.574667646588;6565.376289252514;6703.994400839913;6722.495812814059;6723.764668236686;6494.188226471691;6580.934190658128;6581.308962558958;6586.077949087132;6595.505337099737;6699.866002680016;6703.095082163943;6710.664466776641;6712.429443497357;6720.395164435225;6493.188351456068;6494.415502604788;6495.545311828316;6501.447376972821;6502.804915852343;6222.160008398808;6399.136116624196;6404.93595064062;6407.167068281094;6407.775727849503;6686.966565167143;6711.395974362331;6713.194416669836;6715.3620406061345;6716.597004179765;4489.0572979674635;4490.057088011554;4493.393391892184;4499.572540608637;4508.45898492183;6450.064740612491;6456.451201647725;6463.515236357198;6472.546921715435;6475.838104047248;6257.124002639725;6265.530085243534;6270.7805226816845;6276.152719383008;6291.370862913672;6003.87992240144;6230.127782110418;6231.22109736283;6248.593841400295;6255.218097737783;6088.634681918922;6127.662978536223;6164.506839452923;6172.629642221481;6173.104899789595;6304.495640348853;6309.400606942517;6310.5898116622275;6311.936880631319;6312.179416675803;6036.245469316335;6136.048912418582;6148.569600127948;6149.754009839557;6154.861350650144 14:31:31 INFO - PROCESS | 30868 | |5;yui.html;777.2344240922691;837.7821766340752;856.6958729650974;877.5129802959359;890.1098901098901;14526.41894324227;14654.48709295175;14711.264436778172;14726.263686815657;14750.926245368759;13131.474741010348;13186;13188.736225275488;13192.868071319308;13206.93396533016;705.5378726933841;832.9042160151585;835.6907944060706;847.3687103108163;854.4915775113828;839.3117643532306;853.7310747114639;856.5674334461088;856.8543347630917;857.3998201259144;884.4693184089559;896.2964073202537;898.128815049401;898.3352319283748;899.0604817965242;741.5217184915726;883.4434306387;888.5779254853925;893.2184338703635;899.4423457456419;660.1681880830189;660.7588230295955;660.7753363856264;662.7912207654622;665.1751827733624;13701.657458563615;13751.931240343734;13753.931230343784;13775.448982040707;13787.724245515134;13874.849398343273;14136.08115472491;14174.433022679184;14183;14305.141691498544;10873.184511161615;10901.34591924487;10995.725106872313;11411.25826821254;11443.542258309657;3898.688104951597;3913.158670885745;3924.13668992824;3979.781112038837;3980.402939559089;52540.21189682158;54882.45117548853;55679.72160139214;55999.440005600234;56225.43774562243;11196.272242304223;11280.32318060919;11354.829677554842;11495.597654082067;11571.710707232218;18899.62200755977;19231;19254.903725481283;19260.614787704166;19270.71093933592;8264.338852891755;8394.958025209835;8471.449355791854;8471.745847624581;8626.78433039179;4906.607471402279;5020.849374518771;5053.797848086109;5209.71346575942;5217.660852044605;3470.982645086809;3502.546443226033;3502.5972013218297;3502.772319799256;3507.8421471033867;644.3524258120652;646.5926466326184;646.9708863101172;663.0452148905657;665.6139439125295;610.9847253818601;704.4470090978659;709.9680514376865;721.1022277264734;726.6584705188553;8835.160659737443;9688.806223875483;9701.805963880683;9821.459819709984;9829.115379615869;671.3018460800713;679.1374953808636;698.7659134190002;716.5485743981362;744.5607091815855;4300.182965236658;4412.558744125626;4496.550344965477;4506.301523263899;4528.117017181618;61082.38917610767;62896;63155;63440.68279658572;63462;54509.72745136249;55420.445795542335;55494;55496.445035549936;55808;50308.74845625822;51801;51991.480085198666;52116.47883521268;53474.32628368566;8810.383273170817;8919.687810926845;8929.642814287616;9016.278697704036;9093.181613654539;39556.60443395645;39953;40440.1911961765;40540;41398.58601413947;50208;50540.49459505358;51072.744636276584;51665.48334516607;52262;10904.2646082918;11035.83446248323;11070.889291106985;11242.83135752948;11287.322760634388;11095.667129986114;11507.884921151017;11993.940030299793;12261.570845020382;12309.93845030769;10730.409827459565;10901.182411319025;10943.726406839893;11001.559937602406;11046.226764126433;11641.185117041725;11646.94176529112;11663.475143618387;11671.766564668489;11681.649550513499;11409.144314176305;11419.31484110956;11524.654260372203;11539.538418463168;11568.942155289169;9165.770855728393;9496.810063798823;9571.760705982406;9627.470489123165;9641;9373.757850385498;9515.904840951502;9565.521723913917;9625.807483850424;9734.756631083996 14:31:31 INFO - PROCESS | 30868 | __end_tp_report 14:31:31 INFO - PROCESS | 30868 | __start_cc_report 14:31:31 INFO - PROCESS | 30868 | _x_x_mozilla_cycle_collect,812 14:31:31 INFO - PROCESS | 30868 | __end_cc_report 14:31:31 INFO - PROCESS | 30868 | __startTimestamp1458077491414__endTimestamp 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | ------- Summary: start ------- 14:31:31 INFO - PROCESS | 30868 | Number of tests: 6 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#0] dojo.html Cycles:165 Average:5299.06 Median:5521.14 stddev:601.48 (10.9%) stddev-sans-first:576.63 14:31:31 INFO - PROCESS | 30868 | Values: 3039.8 3059.2 3099.3 3102.6 3130.1 5215.6 5242.6 5246.0 5273.0 5285.7 5359.1 5374.5 5388.5 5400.5 5431.6 4793.6 4796.1 4817.0 4829.3 4962.4 4882.1 4888.9 4891.2 4944.5 4967.8 4765.0 4862.3 4902.3 4914.0 4957.8 4851.7 4863.5 4864.9 4875.0 4884.4 4764.9 4835.7 4835.8 4843.0 4892.6 5191.1 5229.7 5233.9 5235.2 5261.5 5689.0 5707.2 5711.1 5712.0 5713.0 5612.7 5639.4 5725.8 5733.9 5734.3 5353.4 5361.6 5362.5 5363.1 5363.4 5858.2 5860.3 5860.6 5861.2 5863.6 5512.2 5619.8 5629.4 5638.5 5693.9 5714.3 5721.9 5727.9 5730.4 5741.6 5665.2 5671.0 5676.8 5684.5 5687.4 5541.3 5649.0 5677.3 5699.3 5759.9 4338.1 4341.3 4345.8 4348.3 4377.6 3869.6 3876.3 3882.7 3895.0 3912.5 5239.5 5386.4 5415.8 5466.7 5468.3 5702.2 5723.2 5723.3 5743.2 5755.9 5286.9 5359.8 5384.3 5384.8 5419.0 4864.5 4890.5 4896.6 4929.7 4929.8 5857.0 5882.1 5900.2 5901.9 5902.8 5605.3 5702.5 5703.3 5707.1 5757.4 5904.5 5918.0 5920.6 5924.0 5924.6 5627.4 5630.8 5643.4 5647.6 5651.7 5567.2 5701.5 5715.2 5736.3 5783.5 5623.0 5625.6 5626.9 5632.6 5638.7 5559.2 5579.3 5585.6 5587.6 5589.3 5387.3 5428.3 5470.9 5496.4 5549.1 5547.7 5598.8 5620.2 5621.8 5622.6 5482.2 5520.1 5521.1 5521.4 5522.2 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#1] ext.html Cycles:180 Average:47984.28 Median:35313.15 stddev:82761.42 (234.4%) stddev-sans-first:82916.97 14:31:31 INFO - PROCESS | 30868 | Values: 553.4 556.7 576.5 603.5 638.7 29543.6 38122.4 38589.6 38598.8 38673.0 41498.3 42121.4 42144.6 42163.4 42222.8 7954.9 8650.8 8853.3 10090.2 10263.4 10208.4 10378.5 10382.5 10383.8 10391.6 10306.8 10410.6 10415.2 10417.1 10419.2 10213.4 10344.2 10374.2 10381.7 10383.6 10486.7 10619.4 10638.7 10643.9 10650.7 41582.6 41629.0 41741.0 41844.6 41964.4 3615.7 3701.8 3802.5 4198.0 4388.7 30303.2 32558.5 32659.5 32767.3 33898.8 4353.3 4368.7 4372.7 4417.1 4423.3 312419.0 313408.0 313662.0 313834.0 313874.0 47110.8 64078.0 64370.0 64377.4 64461.0 45219.5 45276.3 45385.2 45482.3 45490.3 15584.3 15872.1 15876.6 15892.1 15901.0 12539.1 12575.1 12596.8 12599.4 12613.6 15533.1 15547.9 15823.9 15825.8 15844.5 6212.0 6299.9 6352.6 6370.9 6424.2 977.7 1025.7 1113.0 1121.4 1266.2 32716.7 32898.5 32979.8 33064.3 33390.5 1083.7 1115.8 1118.1 1124.7 1219.0 16277.7 16991.5 17034.9 17112.8 17122.2 400709.0 401859.0 404148.0 405276.0 405563.0 56964.7 57485.4 57521.7 57603.7 57633.7 1227.8 1239.4 1284.5 1349.4 1417.5 28663.9 29704.6 30536.4 32031.5 32169.0 44803.0 45127.3 45152.0 45187.8 45232.8 189925.0 189932.0 190008.0 190320.0 190511.0 31177.2 35059.5 35255.8 35370.5 35691.8 48435.5 48497.0 49126.5 49255.8 49865.0 35696.8 36135.6 36309.3 36714.0 38347.2 38385.8 38864.0 39329.8 39746.6 40579.8 40540.0 40924.8 41104.6 41191.6 41612.6 34848.7 35402.8 35993.5 36059.8 36178.0 27794.0 28009.4 28019.9 28050.7 28063.2 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#2] jquery.html Cycles:180 Average:28658.64 Median:27859.51 stddev:75519.16 (271.1%) stddev-sans-first:75701.16 14:31:31 INFO - PROCESS | 30868 | Values: 378.5 381.9 382.0 384.1 384.5 17538.8 18291.6 19077.9 19095.3 19124.8 19380.3 19386.4 19473.6 20096.9 20099.8 6150.0 6288.5 6305.7 6327.3 6331.2 4506.8 5572.2 6891.2 7174.4 7189.3 6994.2 7042.3 7047.4 7077.2 7091.7 6851.3 7012.9 7020.7 7027.8 7041.0 4351.0 4497.1 6517.6 6738.3 6743.5 22790.2 23261.2 24003.3 24902.4 24933.4 2254.2 2292.2 2410.3 2669.5 2683.8 14489.5 14553.1 14745.0 14853.1 15269.2 2083.9 2127.3 2141.0 2185.1 2276.0 76715.0 82659.0 86002.1 86782.6 86794.0 17753.0 17957.6 18050.2 18075.0 18183.5 27449.2 27499.2 27803.6 27839.7 27879.3 9506.7 9635.8 9852.0 10008.3 10061.0 8456.5 8519.1 8551.7 8624.3 8641.1 8867.7 8875.6 8919.8 8934.9 8997.8 3181.1 3215.8 3249.0 3317.5 3410.2 952.4 1025.1 1035.6 1062.7 1119.3 17291.8 17955.8 18044.8 18252.5 18596.9 952.0 997.9 1006.5 1040.6 1055.5 9844.0 10224.2 10249.6 10420.8 10466.1 450700.0 452048.0 462233.0 465004.0 465278.0 80996.2 82037.0 83663.2 83890.0 83940.0 1083.4 1097.3 1121.5 1123.1 1125.7 15656.1 15811.4 15866.4 15874.0 15925.0 37276.0 37442.3 37773.2 38322.8 38695.8 51497.2 55481.7 55499.0 55645.7 55834.4 7997.9 8201.4 8205.8 8289.2 8302.3 9659.7 11764.9 12600.6 12872.3 12931.4 10697.3 10900.0 11254.5 11257.5 11391.4 11027.7 11162.6 11740.7 11959.8 11996.0 11814.3 12283.6 12381.4 12431.0 12454.5 8286.2 8343.5 8448.7 8649.6 8663.1 10306.6 11933.5 11990.9 12118.6 12242.0 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#3] mootools.html Cycles:180 Average:5843.93 Median:6434.40 stddev:2996.74 (46.6%) stddev-sans-first:2986.92 14:31:31 INFO - PROCESS | 30868 | Values: 1446.6 1551.1 1553.0 1746.5 1885.6 7863.4 8042.5 8044.4 8063.5 8071.0 7853.8 8041.2 8056.4 8062.1 8062.4 2055.3 2355.4 2362.8 2393.7 2398.8 2408.4 2418.0 2419.4 2419.8 2420.3 2312.7 2418.3 2418.9 2419.7 2421.1 2361.3 2381.6 2444.3 2445.5 2446.2 2388.8 2393.8 2403.0 2431.8 2433.8 8202.1 8247.5 8262.5 8263.0 8263.0 5214.6 5327.0 5328.5 5330.8 5332.1 3471.7 3535.8 3589.1 3596.2 3612.2 1134.9 1144.0 1168.9 1195.0 1209.7 11329.4 11420.3 11431.1 11432.3 11472.7 4702.1 4735.3 4796.7 4823.6 4830.7 9776.5 9784.5 9788.5 9789.3 9796.2 4690.9 5285.8 5287.8 5294.0 5300.0 4692.1 4739.6 4780.2 4808.9 4816.3 3891.7 3968.1 3998.7 3999.4 4030.1 1267.1 1279.1 1287.0 1291.9 1300.6 1386.2 1398.5 1421.7 1456.4 1465.2 7921.3 7995.4 7999.3 8010.2 8020.0 499.7 499.7 501.6 1242.5 1317.1 6208.7 6212.2 6274.4 6290.4 6298.6 9604.1 9981.2 9995.8 9996.3 10036.7 9475.2 9572.6 9594.8 9940.6 9944.9 7724.6 7787.1 7850.1 7873.8 7921.2 7750.3 7798.0 7882.8 7893.4 7918.9 8710.6 9018.3 9089.3 9157.0 9209.8 9199.7 9397.7 9408.3 9548.2 9577.9 6570.2 6820.8 6970.5 7308.7 7404.7 7832.6 7862.6 7874.6 7899.2 7901.7 7137.8 7265.9 7272.5 7365.9 7406.7 7271.3 7281.9 7302.1 7312.0 7375.7 7455.6 7542.0 7581.8 7589.1 7593.0 6869.2 6875.5 6928.6 6933.6 6943.2 7029.1 7088.5 7095.4 7101.3 7103.1 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#4] prototype.html Cycles:180 Average:5295.94 Median:6041.09 stddev:1575.72 (26.1%) stddev-sans-first:1535.76 14:31:31 INFO - PROCESS | 30868 | Values: 348.1 349.2 349.6 349.8 350.8 6006.5 6045.9 6059.5 6077.9 6083.8 5953.9 5963.1 5972.0 6058.0 6063.7 4480.4 4557.1 4663.5 4690.3 4718.2 4688.5 4691.7 4700.9 4705.6 4713.7 4639.0 4648.4 4654.6 4660.9 4662.0 4440.6 4549.5 4628.9 4639.1 4641.6 4066.9 4076.8 4077.4 4082.7 4097.6 5756.8 5786.3 5791.8 5798.9 5807.0 5385.9 5399.6 5411.5 5412.9 5417.0 6313.6 6323.3 6333.2 6335.4 6341.2 4284.4 4391.6 4414.7 4424.0 4537.8 6600.5 6666.9 6680.5 6688.1 6691.5 4476.1 4511.0 4515.6 4518.6 4522.4 4572.6 4576.6 4577.2 4578.5 4581.5 5317.3 5318.9 5320.1 5321.6 5330.5 6305.8 6409.9 6452.0 6454.0 6457.3 1583.9 1598.8 1606.7 1609.7 1611.4 1003.7 1027.9 1047.6 1058.1 1069.1 5992.3 6002.3 6006.4 6007.5 6013.9 6366.8 6487.4 6492.8 6498.8 6501.9 6063.8 6064.5 6065.1 6066.3 6076.7 3465.4 3498.2 3503.8 3506.7 3506.7 6543.6 6565.4 6704.0 6722.5 6723.8 6494.2 6580.9 6581.3 6586.1 6595.5 6699.9 6703.1 6710.7 6712.4 6720.4 6493.2 6494.4 6495.5 6501.4 6502.8 6222.2 6399.1 6404.9 6407.2 6407.8 6687.0 6711.4 6713.2 6715.4 6716.6 4489.1 4490.1 4493.4 4499.6 4508.5 6450.1 6456.5 6463.5 6472.5 6475.8 6257.1 6265.5 6270.8 6276.2 6291.4 6003.9 6230.1 6231.2 6248.6 6255.2 6088.6 6127.7 6164.5 6172.6 6173.1 6304.5 6309.4 6310.6 6311.9 6312.2 6036.2 6136.0 6148.6 6149.8 6154.9 14:31:31 INFO - PROCESS | 30868 | 14:31:31 INFO - PROCESS | 30868 | [#5] yui.html Cycles:180 Average:15031.28 Median:28663.10 stddev:17852.42 (62.3%) stddev-sans-first:17870.41 14:31:31 INFO - PROCESS | 30868 | Values: 777.2 837.8 856.7 877.5 890.1 14526.4 14654.5 14711.3 14726.3 14750.9 13131.5 13186.0 13188.7 13192.9 13206.9 705.5 832.9 835.7 847.4 854.5 839.3 853.7 856.6 856.9 857.4 884.5 896.3 898.1 898.3 899.1 741.5 883.4 888.6 893.2 899.4 660.2 660.8 660.8 662.8 665.2 13701.7 13751.9 13753.9 13775.4 13787.7 13874.8 14136.1 14174.4 14183.0 14305.1 10873.2 10901.3 10995.7 11411.3 11443.5 3898.7 3913.2 3924.1 3979.8 3980.4 52540.2 54882.5 55679.7 55999.4 56225.4 11196.3 11280.3 11354.8 11495.6 11571.7 18899.6 19231.0 19254.9 19260.6 19270.7 8264.3 8395.0 8471.4 8471.7 8626.8 4906.6 5020.8 5053.8 5209.7 5217.7 3471.0 3502.5 3502.6 3502.8 3507.8 644.4 646.6 647.0 663.0 665.6 611.0 704.4 710.0 721.1 726.7 8835.2 9688.8 9701.8 9821.5 9829.1 671.3 679.1 698.8 716.5 744.6 4300.2 4412.6 4496.6 4506.3 4528.1 61082.4 62896.0 63155.0 63440.7 63462.0 54509.7 55420.4 55494.0 55496.4 55808.0 50308.7 51801.0 51991.5 52116.5 53474.3 8810.4 8919.7 8929.6 9016.3 9093.2 39556.6 39953.0 40440.2 40540.0 41398.6 50208.0 50540.5 51072.7 51665.5 52262.0 10904.3 11035.8 11070.9 11242.8 11287.3 11095.7 11507.9 11993.9 12261.6 12309.9 10730.4 10901.2 10943.7 11001.6 11046.2 11641.2 11646.9 11663.5 11671.8 11681.6 11409.1 11419.3 11524.7 11539.5 11568.9 9165.8 9496.8 9571.8 9627.5 9641.0 9373.8 9515.9 9565.5 9625.8 9734.8 14:31:31 INFO - PROCESS | 30868 | -------- Summary: end -------- 14:31:31 INFO - PROCESS | 30868 | 14:31:32 INFO - TEST-INFO | 30868: exit 0 14:31:32 INFO - TEST-OK | dromaeo_css | took 1110352ms 14:31:32 INFO - TEST-START | kraken 14:31:32 INFO - operating with platform_type : linux_ 14:31:32 INFO - Initialising browser for kraken test... 14:31:32 INFO - TEST-INFO | started process 31054 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8GuqIq/profile http://localhost:52996/getInfo.html) 14:31:35 INFO - PROCESS | 31054 | __metrics Screen width/height:1600/1200 14:31:35 INFO - PROCESS | 31054 | colorDepth:24 14:31:35 INFO - PROCESS | 31054 | Browser inner width/height: 1024/697 14:31:35 INFO - PROCESS | 31054 | __metrics 14:31:36 ERROR - PROCESS | 31054 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:31:37 INFO - TEST-INFO | 31054: exit 0 14:31:37 INFO - Browser initialized. 14:31:37 INFO - Running cycle 1/1 for kraken test... 14:31:37 INFO - TEST-INFO | started process 31136 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8GuqIq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:49 INFO - PROCESS | 31136 | RSS: Main: 153432064 14:31:49 INFO - PROCESS | 31136 | 14:31:51 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52996/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:52 INFO - PROCESS | 31136 | RSS: Main: 195153920 14:31:52 INFO - PROCESS | 31136 | 14:31:55 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52996/tests/kraken/driver.html?testName=audio-dft) 14:31:55 INFO - PROCESS | 31136 | RSS: Main: 184774656 14:31:55 INFO - PROCESS | 31136 | 14:31:58 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52996/tests/kraken/driver.html?testName=audio-fft) 14:31:59 INFO - PROCESS | 31136 | RSS: Main: 168787968 14:31:59 INFO - PROCESS | 31136 | 14:32:01 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52996/tests/kraken/driver.html?testName=audio-oscillator) 14:32:01 INFO - PROCESS | 31136 | RSS: Main: 171683840 14:32:01 INFO - PROCESS | 31136 | 14:32:03 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:04 INFO - PROCESS | 31136 | RSS: Main: 174022656 14:32:04 INFO - PROCESS | 31136 | 14:32:07 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52996/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:07 INFO - PROCESS | 31136 | RSS: Main: 174358528 14:32:07 INFO - PROCESS | 31136 | 14:32:11 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52996/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:11 INFO - PROCESS | 31136 | RSS: Main: 176005120 14:32:11 INFO - PROCESS | 31136 | 14:32:14 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52996/tests/kraken/driver.html?testName=json-parse-financial) 14:32:15 INFO - PROCESS | 31136 | RSS: Main: 174862336 14:32:15 INFO - PROCESS | 31136 | 14:32:16 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:17 INFO - PROCESS | 31136 | RSS: Main: 183943168 14:32:17 INFO - PROCESS | 31136 | 14:32:19 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:19 INFO - PROCESS | 31136 | RSS: Main: 180150272 14:32:19 INFO - PROCESS | 31136 | 14:32:21 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:22 INFO - PROCESS | 31136 | RSS: Main: 192528384 14:32:22 INFO - PROCESS | 31136 | 14:32:24 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:25 INFO - PROCESS | 31136 | RSS: Main: 197464064 14:32:25 INFO - PROCESS | 31136 | 14:32:27 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:28 INFO - PROCESS | 31136 | RSS: Main: 198254592 14:32:28 INFO - PROCESS | 31136 | 14:32:29 INFO - PROCESS | 31136 | Cycle 1(1): loaded http://localhost:52996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52996/tests/kraken/driver.html?testName=ai-astar) 14:32:30 INFO - PROCESS | 31136 | RSS: Main: 257675264 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | __start_tp_report 14:32:30 INFO - PROCESS | 31136 | _x_x_mozilla_page_load 14:32:30 INFO - PROCESS | 31136 | _x_x_mozilla_page_load_details 14:32:30 INFO - PROCESS | 31136 | |i|pagename|runs| 14:32:30 INFO - PROCESS | 31136 | |0;ai-astar;110;112;107;111;112;112;100;110;110;109 14:32:30 INFO - PROCESS | 31136 | |1;audio-beat-detection;155;121;153;169;134;153;150;125;180;125 14:32:30 INFO - PROCESS | 31136 | |2;audio-dft;159;161;161;160;159;162;160;163;160;160 14:32:30 INFO - PROCESS | 31136 | |3;audio-fft;75;76;95;94;76;75;73;112;97;76 14:32:30 INFO - PROCESS | 31136 | |4;audio-oscillator;93;91;144;93;92;93;149;93;93;138 14:32:30 INFO - PROCESS | 31136 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 14:32:30 INFO - PROCESS | 31136 | |6;imaging-darkroom;145;145;146;146;145;145;145;145;145;145 14:32:30 INFO - PROCESS | 31136 | |7;imaging-desaturate;95;95;95;97;95;95;95;95;95;96 14:32:30 INFO - PROCESS | 31136 | |8;json-parse-financial;56;56;55;57;57;56;56;65;55;54 14:32:30 INFO - PROCESS | 31136 | |9;json-stringify-tinderbox;60;59;58;59;59;59;60;65;59;60 14:32:30 INFO - PROCESS | 31136 | |10;stanford-crypto-aes;79;78;78;77;84;76;77;78;79;76 14:32:30 INFO - PROCESS | 31136 | |11;stanford-crypto-ccm;109;110;112;105;109;123;113;107;107;111 14:32:30 INFO - PROCESS | 31136 | |12;stanford-crypto-pbkdf2;151;128;136;146;135;124;137;135;136;134 14:32:30 INFO - PROCESS | 31136 | |13;stanford-crypto-sha256-iterative;64;65;66;65;66;66;64;66;63;63 14:32:30 INFO - PROCESS | 31136 | __end_tp_report 14:32:30 INFO - PROCESS | 31136 | __start_cc_report 14:32:30 INFO - PROCESS | 31136 | _x_x_mozilla_cycle_collect,1035 14:32:30 INFO - PROCESS | 31136 | __end_cc_report 14:32:30 INFO - PROCESS | 31136 | __startTimestamp1458077550133__endTimestamp 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | ------- Summary: start ------- 14:32:30 INFO - PROCESS | 31136 | Number of tests: 14 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.62 (3.3%) stddev-sans-first:3.83 14:32:30 INFO - PROCESS | 31136 | Values: 110.0 112.0 107.0 111.0 112.0 112.0 100.0 110.0 110.0 109.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:153.00 stddev:19.80 (12.9%) stddev-sans-first:20.76 14:32:30 INFO - PROCESS | 31136 | Values: 155.0 121.0 153.0 169.0 134.0 153.0 150.0 125.0 180.0 125.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 14:32:30 INFO - PROCESS | 31136 | Values: 159.0 161.0 161.0 160.0 159.0 162.0 160.0 163.0 160.0 160.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#3] audio-fft Cycles:10 Average:84.90 Median:76.00 stddev:13.50 (17.8%) stddev-sans-first:13.84 14:32:30 INFO - PROCESS | 31136 | Values: 75.0 76.0 95.0 94.0 76.0 75.0 73.0 112.0 97.0 76.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:24.83 (26.7%) stddev-sans-first:25.74 14:32:30 INFO - PROCESS | 31136 | Values: 93.0 91.0 144.0 93.0 92.0 93.0 149.0 93.0 93.0 138.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:32:30 INFO - PROCESS | 31136 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:32:30 INFO - PROCESS | 31136 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:32:30 INFO - PROCESS | 31136 | Values: 95.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.23 14:32:30 INFO - PROCESS | 31136 | Values: 56.0 56.0 55.0 57.0 57.0 56.0 56.0 65.0 55.0 54.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.50 stddev:1.93 (3.2%) stddev-sans-first:2.05 14:32:30 INFO - PROCESS | 31136 | Values: 60.0 59.0 58.0 59.0 59.0 59.0 60.0 65.0 59.0 60.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:2.42 14:32:30 INFO - PROCESS | 31136 | Values: 79.0 78.0 78.0 77.0 84.0 76.0 77.0 78.0 79.0 76.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#11] stanford-crypto-ccm Cycles:10 Average:110.60 Median:110.50 stddev:4.99 (4.5%) stddev-sans-first:5.26 14:32:30 INFO - PROCESS | 31136 | Values: 109.0 110.0 112.0 105.0 109.0 123.0 113.0 107.0 107.0 111.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:136.00 stddev:7.74 (5.7%) stddev-sans-first:6.09 14:32:30 INFO - PROCESS | 31136 | Values: 151.0 128.0 136.0 146.0 135.0 124.0 137.0 135.0 136.0 134.0 14:32:30 INFO - PROCESS | 31136 | 14:32:30 INFO - PROCESS | 31136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:1.23 (1.9%) stddev-sans-first:1.27 14:32:30 INFO - PROCESS | 31136 | Values: 64.0 65.0 66.0 65.0 66.0 66.0 64.0 66.0 63.0 63.0 14:32:30 INFO - PROCESS | 31136 | -------- Summary: end -------- 14:32:30 INFO - PROCESS | 31136 | 14:32:31 INFO - TEST-INFO | 31136: exit 0 14:32:31 INFO - TEST-OK | kraken | took 58966ms 14:32:31 INFO - SUITE-END | took 1169s 14:32:31 INFO - Completed test suite (00:19:29) 14:32:31 INFO - javascript benchmark 14:32:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3039.8480075996195, 3059.1893148315685, 3099.333643266699, 3102.6431960324553, 3130.0766273949184, 5215.6349055566125, 5242.554382877455, 5245.973770131149, 5272.973635131823, 5285.656432331895, 5359.062164121273, 5374.543163831069, 5388.515033646971, 5400.486953739389, 5431.646942948705, 4793.5685788279225, 4796.08874313881, 4816.97591512042, 4829.3480380148585, 4962.379702537183, 4882.121218180726, 4888.853334399973, 4891.192953162724, 4944.456109827934, 4967.826126085588, 4765.046990601893, 4862.29496722975, 4902.338184345103, 4914.04176185644, 4957.7769000395065, 4851.733154676492, 4863.513648635144, 4864.902701945976, 4875.049365373754, 4884.413870335547, 4764.904701905977, 4835.709857408567, 4835.806567737286, 4842.975785121052, 4892.633052521075, 5191.091558977164, 5229.660072095302, 5233.895322093575, 5235.1623740201385, 5261.473852614746, 5689.0, 5707.229524014288, 5711.114777209539, 5711.971440142815, 5713.000224960615, 5612.663240205601, 5639.436056394369, 5725.799597014126, 5733.856653583652, 5734.283214598176, 5353.38436079848, 5361.624686271963, 5362.544183744387, 5363.088274993222, 5363.436839131913, 5858.209141765892, 5860.2967643883, 5860.648361098262, 5861.17943487912, 5863.560232982543, 5512.173174023848, 5619.831405057855, 5629.352624448241, 5638.464345887134, 5693.886122277614, 5714.285714285715, 5721.885562288731, 5727.914081288784, 5730.36965933747, 5741.62679425836, 5665.178549110356, 5671.0, 5676.829695109153, 5684.516816070598, 5687.374388817227, 5541.307336582927, 5648.971755141198, 5677.347105082886, 5699.316082070095, 5759.942400576025, 4338.089001309697, 4341.305391137403, 4345.782710864444, 4348.260795664744, 4377.6497880170145, 3869.5936926622862, 3876.282887665791, 3882.650561449483, 3894.9805250973563, 3912.5109361329833, 5239.476052394806, 5386.434424385461, 5415.783368665288, 5466.6993315367245, 5468.316460442445, 5702.230198923092, 5723.170140329629, 5723.313202415654, 5743.167240750151, 5755.913661295084, 5286.8942621148135, 5359.812406565751, 5384.273123128406, 5384.784608615611, 5419.024575576355, 4864.489228630943, 4890.535399137077, 4896.559309662148, 4929.704217746947, 4929.802807887644, 5857.0, 5882.088276317178, 5900.1739756434135, 5901.940980590139, 5902.763889444374, 5605.271314729059, 5702.515286200636, 5703.287089113861, 5707.086866101404, 5757.395473475225, 5904.527637789052, 5917.970410147922, 5920.555958303231, 5924.0, 5924.644521328734, 5627.409122042127, 5630.774769009194, 5643.407442218508, 5647.604667673223, 5651.660900345993, 5567.220589117445, 5701.486866182064, 5715.228444159985, 5736.311642602915, 5783.508401785895, 5622.971885140548, 5625.606207565431, 5626.88746225065, 5632.605717599728, 5638.746256418389, 5559.249501317432, 5579.2746942897165, 5585.581081418991, 5587.55299576041, 5589.329280486368, 5387.299651045339, 5428.294321738149, 5470.890582188414, 5496.422875598165, 5549.084401073777, 5547.667139971614, 5598.804041858678, 5620.1569764534015, 5621.803236886853, 5622.606417550732, 5482.205080263419, 5520.089185284543, 5521.1442226454965, 5521.3926468089285, 5522.171674248895], "unit": "score", "name": "dojo.html", "value": 5258.3201201053225}, {"lowerIsBetter": false, "replicates": [553.3581045986656, 556.6882545774364, 576.4696479239101, 603.4689473263527, 638.7157714816902, 29543.55684664729, 38122.42816357753, 38589.614103858956, 38598.807005965, 38673.0, 41498.265156135945, 42121.36817947726, 42144.57855421445, 42163.367549486786, 42222.788886055525, 7954.880676789853, 8650.826983460327, 8853.335999800009, 10090.192784577253, 10263.384196948207, 10208.387496750182, 10378.532966016548, 10382.532786024647, 10383.792324153512, 10391.584336626564, 10306.793864122714, 10410.583576656925, 10415.166786657088, 10417.114545263661, 10419.166466682647, 10213.438260895648, 10344.172466202686, 10374.221933354991, 10381.740456488647, 10383.636572719955, 10486.685399437953, 10619.41593212373, 10638.73403164927, 10643.893561064368, 10650.680479585548, 41582.58417415847, 41629.0, 41741.0, 41844.581554184675, 41964.37053444201, 3615.6745892869503, 3701.777893326382, 3802.524684414448, 4197.97901010493, 4388.692791504596, 30303.242418939484, 32558.511622325685, 32659.510107348407, 32767.344653106804, 33898.83050584756, 4353.28170851809, 4368.694191406603, 4372.656532485344, 4417.09449562842, 4423.270160423526, 312419.0, 313408.0, 313662.0, 313834.0, 313874.0, 47110.76444617823, 64078.0, 64370.0, 64377.356226438074, 64461.0, 45219.547804521535, 45276.3208551872, 45385.2345503724, 45482.31776523355, 45490.31764523535, 15584.298706558006, 15872.127033013065, 15876.603084922739, 15892.125933073792, 15901.0, 12539.059570532247, 12575.056870734732, 12596.81104783429, 12599.433025513874, 12613.621591352274, 15533.145676987648, 15547.922260388852, 15823.920880395755, 15825.762613560575, 15844.52466426009, 6211.9689401552705, 6299.874002519924, 6352.555321127569, 6370.904436433457, 6424.229092508929, 977.6578197630914, 1025.733309339577, 1112.9888701113048, 1121.3664279681955, 1266.2022925557023, 32716.672833271838, 32898.50652240218, 32979.83510082434, 33064.33871322608, 33390.49914251288, 1083.707399002265, 1115.7991561519004, 1118.0999295567146, 1124.7244425115898, 1219.0491416694992, 16277.674446511004, 16991.49025529236, 17034.91482542604, 17112.828871711372, 17122.229499672543, 400709.0, 401859.0, 404148.0, 405276.0, 405563.0, 56964.71517642468, 57485.42514574884, 57521.71239143777, 57603.711981439825, 57633.711831440574, 1227.7851376009162, 1239.3555351217317, 1284.4862055177816, 1349.413005342679, 1417.5392997275721, 28663.856680716464, 29704.554431683973, 30536.389272214874, 32031.519527206645, 32169.0, 44803.0, 45127.32309015302, 45152.0, 45187.774061130796, 45232.77383613193, 189925.0, 189932.0, 190008.0, 190320.0, 190511.0, 31177.220569485944, 35059.474107887894, 35255.82372088123, 35370.46944295889, 35691.821540893165, 48435.5156448431, 48497.0, 49126.5087349122, 49255.753721231165, 49865.0, 35696.821515892254, 36135.63864361428, 36309.27381452303, 36714.0, 38347.2330553393, 38385.808070959465, 38864.02839928911, 39329.803350983064, 39746.60253397429, 40579.79710101431, 40540.0, 40924.79537602412, 41104.58895411008, 41191.588084118775, 41612.58387416087, 34848.65151348454, 35402.82298588491, 35993.46009809907, 36059.81970090133, 36178.0, 27794.0, 28009.43981120407, 28019.85990070118, 28050.719492805627, 28063.158105256876], "unit": "score", "name": "ext.html", "value": 19372.216398684643}, {"lowerIsBetter": false, "replicates": [378.5079396784181, 381.9446180303856, 381.9503464549608, 384.1241968312249, 384.49438987731133, 17538.82461175388, 18291.63416731666, 19077.85532868029, 19095.331663391786, 19124.808751912493, 19380.321688740896, 19386.4184074478, 19473.610527789435, 20096.88982656822, 20099.789023207435, 6150.0, 6288.496920246369, 6305.716242769086, 6327.335629758878, 6331.176946996907, 4506.8422605208825, 5572.219889215513, 6891.173059232874, 7174.426045916341, 7189.281071892821, 6994.230634630212, 7042.330978557029, 7047.365737083662, 7077.186123595775, 7091.71633134674, 6851.3491218334175, 7012.859742805115, 7020.7191712331705, 7027.789166324993, 7040.964795176017, 4350.978245108786, 4497.078098989699, 6517.608943463408, 6738.326167383271, 6743.460523158135, 22790.202342918084, 23261.185858495042, 24003.27990160298, 24902.37744056395, 24933.376665583324, 2254.1997590855176, 2292.1633603734685, 2410.288964755401, 2669.479451506957, 2683.771879390254, 14489.492867749577, 14553.126812391185, 14745.0, 14853.108813471119, 15269.236538173158, 2083.8853863037525, 2127.2660931978444, 2141.0365335598885, 2185.136870935987, 2275.988620056906, 76715.0, 82659.0, 86002.13997860067, 86782.56608716917, 86794.0, 17753.0, 17957.551061223312, 18050.1877415514, 18075.0, 18183.45449636513, 27449.17652470429, 27499.17502474929, 27803.58294625582, 27839.721602783713, 27879.303017424725, 9506.667266645634, 9635.807283854283, 9851.950740246397, 10008.299419040743, 10061.0, 8456.492610443393, 8519.06290308078, 8551.700690475804, 8624.310055195569, 8641.092685267957, 8867.68963086289, 8875.600597973107, 8919.770057485628, 8934.86597701035, 8997.820043599091, 3181.0933883842995, 3215.7748957573212, 3249.0, 3317.4857897025518, 3410.215650400422, 952.3999880075509, 1025.123519390925, 1035.5805898611075, 1062.6652604429735, 1119.3451830679144, 17291.82708172902, 17955.820441795677, 18044.819551804576, 18252.54368640768, 18596.907015464836, 951.9714408567754, 997.8973234575834, 1006.4866917871938, 1040.625374865048, 1055.4617145255975, 9844.015598440099, 10224.182065434747, 10249.590016399261, 10420.759536699647, 10466.11038061758, 450700.0, 452048.0, 462233.0, 465004.0, 465278.0, 80996.16513422002, 82037.0, 83663.16336836676, 83890.0, 83940.0, 1083.4420273559124, 1097.2703152403562, 1121.545773961547, 1123.07346439188, 1125.662301309604, 15656.13891235993, 15811.367545298059, 15866.44467443634, 15874.0, 15925.0, 37276.0, 37442.25115497729, 37773.24453510969, 38322.80838595789, 38695.80652096721, 51497.22754158766, 55481.72259138679, 55499.0, 55645.72177139088, 55834.391465621404, 7997.92002079995, 8201.42590018693, 8205.83588328242, 8289.171082891662, 8302.294304984143, 9659.71020869375, 11764.88235117672, 12600.621981340575, 12872.292023938773, 12931.418086185957, 10697.251192416456, 10900.0, 11254.549818007188, 11257.493412796608, 11391.373474458984, 11027.669169924915, 11162.55349786032, 11740.706482337668, 11959.76080478403, 11995.980341671057, 11814.291142531476, 12283.631491055283, 12381.442835072263, 12431.0, 12454.501819927464, 8286.212809783061, 8343.499390036617, 8448.704295349633, 8649.56752162402, 8663.090375510481, 10306.587736490457, 11933.52265909354, 11990.940045300067, 12118.575849845212, 12242.0], "unit": "score", "name": "jquery.html", "value": 10064.922109022722}, {"lowerIsBetter": false, "replicates": [1446.5804916574193, 1551.0771091200736, 1552.9611759706006, 1746.4673274651227, 1885.59459716161, 7863.449558530905, 8042.51744895306, 8044.396670249733, 8063.475874068182, 8071.0, 7853.764387068397, 8041.236082572161, 8056.436049476539, 8062.113167551579, 8062.435629505937, 2055.332017094443, 2355.3640517060385, 2362.787349138577, 2393.6768536247646, 2398.8440751351195, 2408.397900524869, 2417.9637305440433, 2419.41933935855, 2419.7822196002357, 2420.298113547069, 2312.6646636237733, 2418.3349578865777, 2418.903243870243, 2419.733829278778, 2421.092090466075, 2361.327021798788, 2381.6070348392495, 2444.340028192378, 2445.4986727720775, 2446.1683027770555, 2388.79695225906, 2393.8084953203875, 2402.9519409611885, 2431.8297719159664, 2433.7809597136343, 8202.097769245378, 8247.463914845515, 8262.462939908946, 8262.958685206535, 8263.049749278789, 5214.60890433219, 5326.98787230425, 5328.5470734987575, 5330.813421530228, 5332.120200166968, 3471.698113207547, 3535.7878527288444, 3589.1206654369585, 3596.1908570571672, 3612.223371975038, 1134.9432528373547, 1143.9656810295705, 1168.8772678868681, 1195.0141133564757, 1209.6552482542522, 11329.376884271443, 11420.257683250646, 11431.08551315901, 11432.256903301259, 11472.71318217043, 4702.130105930414, 4735.289706544046, 4796.712197268175, 4823.589994850477, 4830.686005409708, 9776.51117444125, 9784.461854598065, 9788.461634610023, 9789.265805064648, 9796.16732577739, 4690.859274221779, 5285.841424757264, 5287.814926477632, 5294.047071527162, 5299.973500132474, 4692.0850434165695, 4739.644526660514, 4780.235162374073, 4808.855734327975, 4816.277558366273, 3891.7081218908697, 3968.146848427602, 3998.7000974926414, 3999.420084087791, 4030.0730831908827, 1267.0560432477862, 1279.1365828066018, 1286.9678258043623, 1291.8966482681362, 1300.6163181861373, 1386.1890793885489, 1398.4965412451509, 1421.6943357178257, 1456.4174330267765, 1465.1648560320727, 7921.287084162453, 7995.40034497415, 7999.3200577950365, 8010.239027292398, 8020.0, 499.67521111277233, 499.6827014845599, 501.6187697349967, 1242.515418986596, 1317.0517227596115, 6208.658523781235, 6212.223472065992, 6274.435300822948, 6290.402411770874, 6298.559100862895, 9604.135627793392, 9981.201503879673, 9995.800083998425, 9996.300258981946, 10036.749081273027, 9475.241980641533, 9572.56923438447, 9594.760130996641, 9940.602375905028, 9944.900550994542, 7724.575148366781, 7787.143414224431, 7850.136484986647, 7873.763787086511, 7921.207879212033, 7750.263724946121, 7798.025246844145, 7882.763517094496, 7893.447458677838, 7918.920810791818, 8710.564471776512, 9018.278537717099, 9089.31830112731, 9157.0, 9209.76975575616, 9199.678011269574, 9397.671081512115, 9408.341416100808, 9548.188403985461, 9577.856332155163, 6570.244421891352, 6820.829479263058, 6970.477214209056, 7308.671109799965, 7404.740834070997, 7832.647530861011, 7862.60686965638, 7874.56689882062, 7899.210078992055, 7901.68393264263, 7137.785866424016, 7265.891011634724, 7272.527285726411, 7365.852682946418, 7406.666699998405, 7271.3455788979245, 7281.927180728337, 7302.123745150616, 7312.049433573601, 7375.704971801068, 7455.552666840007, 7541.962290188514, 7581.810454738676, 7589.051368578927, 7593.0, 6869.175698916162, 6875.519270856558, 6928.584284942919, 6933.583984960918, 6943.166819981635, 7029.0862187915245, 7088.539244949062, 7095.361417472453, 7101.289871013064, 7103.112110986127], "unit": "score", "name": "mootools.html", "value": 4794.326219005276}, {"lowerIsBetter": false, "replicates": [348.1036331446526, 349.24911440403133, 349.6486031538304, 349.8460677301987, 350.80355001199337, 6006.489448396892, 6045.939540604592, 6059.484943779778, 6077.939220607793, 6083.847903802407, 5953.910691339634, 5963.105534169877, 5972.044472884329, 6058.0, 6063.6968151592355, 4480.350349199364, 4557.111363284161, 4663.4637016743, 4690.296455531663, 4718.19790635591, 4688.523115218695, 4691.671582989192, 4700.905981880361, 4705.576498115169, 4713.740744259065, 4638.976805115986, 4648.442186937556, 4654.627629789608, 4660.930086048712, 4661.953380466202, 4440.600345968862, 4549.545045495441, 4628.907421851578, 4639.095376401603, 4641.628669706415, 4066.9389959150635, 4076.7757773322455, 4077.4495443115097, 4082.7142100053006, 4097.631213190827, 5756.7985120521, 5786.334571524287, 5791.7837254176675, 5798.884022319572, 5807.0, 5385.919211211835, 5399.595030372699, 5411.458854114597, 5412.91880621791, 5416.972915135439, 6313.558050936436, 6323.336049714806, 6333.24001119864, 6335.3981371769605, 6341.1756471658855, 4284.378765079077, 4391.6047555719815, 4414.6688998324935, 4423.955760442386, 4537.77311134442, 6600.537962342638, 6666.899996500057, 6680.465562754968, 6688.130543029423, 6691.464682825363, 4476.149531588988, 4510.977445112819, 4515.593596576324, 4518.593326600556, 4522.412086428743, 4572.634189264851, 4576.633869290449, 4577.176108300538, 4578.450585929643, 4581.473130589959, 5317.335333083364, 5318.9202161967605, 5320.095583750772, 5321.574274058066, 5330.466953304638, 6305.795240796625, 6409.871802563923, 6451.967740161269, 6453.967730161413, 6457.2574153971955, 1583.8732901367862, 1598.7521934100232, 1606.7348887433677, 1609.7424412094008, 1611.4440518021263, 1003.7390278527636, 1027.897210278981, 1047.586203449633, 1058.0636137018794, 1069.1340014588052, 5992.250968628921, 6002.339742628307, 6006.429389208019, 6007.519398448114, 6013.909791353133, 6366.77716279928, 6487.35126487357, 6492.837679058061, 6498.805035848932, 6501.902471462932, 6063.787767428207, 6064.4541991221, 6065.090236464565, 6066.332703402622, 6076.665783381956, 3465.3935561276676, 3498.160441494074, 3503.789772613651, 3506.7019303359502, 3506.7194624429985, 6543.574667646588, 6565.376289252514, 6703.994400839913, 6722.495812814059, 6723.764668236686, 6494.188226471691, 6580.934190658128, 6581.308962558958, 6586.077949087132, 6595.505337099737, 6699.866002680016, 6703.095082163943, 6710.664466776641, 6712.429443497357, 6720.395164435225, 6493.188351456068, 6494.415502604788, 6495.545311828316, 6501.447376972821, 6502.804915852343, 6222.160008398808, 6399.136116624196, 6404.93595064062, 6407.167068281094, 6407.775727849503, 6686.966565167143, 6711.395974362331, 6713.194416669836, 6715.3620406061345, 6716.597004179765, 4489.0572979674635, 4490.057088011554, 4493.393391892184, 4499.572540608637, 4508.45898492183, 6450.064740612491, 6456.451201647725, 6463.515236357198, 6472.546921715435, 6475.838104047248, 6257.124002639725, 6265.530085243534, 6270.7805226816845, 6276.152719383008, 6291.370862913672, 6003.87992240144, 6230.127782110418, 6231.22109736283, 6248.593841400295, 6255.218097737783, 6088.634681918922, 6127.662978536223, 6164.506839452923, 6172.629642221481, 6173.104899789595, 6304.495640348853, 6309.400606942517, 6310.5898116622275, 6311.936880631319, 6312.179416675803, 6036.245469316335, 6136.048912418582, 6148.569600127948, 6149.754009839557, 6154.861350650144], "unit": "score", "name": "prototype.html", "value": 4783.65078970261}, {"lowerIsBetter": false, "replicates": [777.2344240922691, 837.7821766340752, 856.6958729650974, 877.5129802959359, 890.1098901098901, 14526.41894324227, 14654.48709295175, 14711.264436778172, 14726.263686815657, 14750.926245368759, 13131.474741010348, 13186.0, 13188.736225275488, 13192.868071319308, 13206.93396533016, 705.5378726933841, 832.9042160151585, 835.6907944060706, 847.3687103108163, 854.4915775113828, 839.3117643532306, 853.7310747114639, 856.5674334461088, 856.8543347630917, 857.3998201259144, 884.4693184089559, 896.2964073202537, 898.128815049401, 898.3352319283748, 899.0604817965242, 741.5217184915726, 883.4434306387, 888.5779254853925, 893.2184338703635, 899.4423457456419, 660.1681880830189, 660.7588230295955, 660.7753363856264, 662.7912207654622, 665.1751827733624, 13701.657458563615, 13751.931240343734, 13753.931230343784, 13775.448982040707, 13787.724245515134, 13874.849398343273, 14136.08115472491, 14174.433022679184, 14183.0, 14305.141691498544, 10873.184511161615, 10901.34591924487, 10995.725106872313, 11411.25826821254, 11443.542258309657, 3898.688104951597, 3913.158670885745, 3924.13668992824, 3979.781112038837, 3980.402939559089, 52540.21189682158, 54882.45117548853, 55679.72160139214, 55999.440005600234, 56225.43774562243, 11196.272242304223, 11280.32318060919, 11354.829677554842, 11495.597654082067, 11571.710707232218, 18899.62200755977, 19231.0, 19254.903725481283, 19260.614787704166, 19270.71093933592, 8264.338852891755, 8394.958025209835, 8471.449355791854, 8471.745847624581, 8626.78433039179, 4906.607471402279, 5020.849374518771, 5053.797848086109, 5209.71346575942, 5217.660852044605, 3470.982645086809, 3502.546443226033, 3502.5972013218297, 3502.772319799256, 3507.8421471033867, 644.3524258120652, 646.5926466326184, 646.9708863101172, 663.0452148905657, 665.6139439125295, 610.9847253818601, 704.4470090978659, 709.9680514376865, 721.1022277264734, 726.6584705188553, 8835.160659737443, 9688.806223875483, 9701.805963880683, 9821.459819709984, 9829.115379615869, 671.3018460800713, 679.1374953808636, 698.7659134190002, 716.5485743981362, 744.5607091815855, 4300.182965236658, 4412.558744125626, 4496.550344965477, 4506.301523263899, 4528.117017181618, 61082.38917610767, 62896.0, 63155.0, 63440.68279658572, 63462.0, 54509.72745136249, 55420.445795542335, 55494.0, 55496.445035549936, 55808.0, 50308.74845625822, 51801.0, 51991.480085198666, 52116.47883521268, 53474.32628368566, 8810.383273170817, 8919.687810926845, 8929.642814287616, 9016.278697704036, 9093.181613654539, 39556.60443395645, 39953.0, 40440.1911961765, 40540.0, 41398.58601413947, 50208.0, 50540.49459505358, 51072.744636276584, 51665.48334516607, 52262.0, 10904.2646082918, 11035.83446248323, 11070.889291106985, 11242.83135752948, 11287.322760634388, 11095.667129986114, 11507.884921151017, 11993.940030299793, 12261.570845020382, 12309.93845030769, 10730.409827459565, 10901.182411319025, 10943.726406839893, 11001.559937602406, 11046.226764126433, 11641.185117041725, 11646.94176529112, 11663.475143618387, 11671.766564668489, 11681.649550513499, 11409.144314176305, 11419.31484110956, 11524.654260372203, 11539.538418463168, 11568.942155289169, 9165.770855728393, 9496.810063798823, 9571.760705982406, 9627.470489123165, 9641.0, 9373.757850385498, 9515.904840951502, 9565.521723913917, 9625.807483850424, 9734.756631083996], "unit": "score", "name": "yui.html", "value": 6749.755551046009}], "name": "dromaeo_css", "value": 7358.262276707248}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 111.0, 112.0, 112.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 153.0, 169.0, 134.0, 153.0, 150.0, 125.0, 180.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 161.0, 160.0, 159.0, 162.0, 160.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 95.0, 94.0, 76.0, 75.0, 73.0, 112.0, 97.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 144.0, 93.0, 92.0, 93.0, 149.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 57.0, 57.0, 56.0, 56.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0, 65.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.8}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 78.0, 77.0, 84.0, 76.0, 77.0, 78.0, 79.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 112.0, 105.0, 109.0, 123.0, 113.0, 107.0, 107.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 110.6}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 136.0, 146.0, 135.0, 124.0, 137.0, 135.0, 136.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 65.0, 66.0, 66.0, 64.0, 66.0, 63.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1472.6999999999998}]} 14:32:31 INFO - Return code: 0 14:32:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:32:31 ERROR - # TBPL SUCCESS # 14:32:31 INFO - Running post-action listener: _resource_record_post_action 14:32:31 INFO - Running post-run listener: _resource_record_post_run 14:32:32 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536018944; Read time: 8; Write time: 721704 14:32:32 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254648320; Read time: 0; Write time: 461616 14:32:32 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281370624; Read time: 8; Write time: 260088 14:32:32 INFO - Running post-run listener: _upload_blobber_files 14:32:32 INFO - Blob upload gear active. 14:32:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:32:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:32:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:32:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:32:32 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:33 INFO - (blobuploader) - INFO - Done attempting. 14:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:34 INFO - (blobuploader) - INFO - Done attempting. 14:32:34 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:34 INFO - Return code: 0 14:32:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:32:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51df3e242fb1cb6ade6c68171c30154e35b2b582b623adc4abfb7458a9525ea5eb4b1a2c9bd5b6e2f41f39c2762598a0092b12dba350b5abef6acd71854fe809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/227f6c3194bc4f86396728cbf91e22b0d0100812437cabeb35ebcdef06b631e105835c3994099849861220318f630b8208a7110a6ae59ceee17e064c7ce9128a"} 14:32:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:32:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:32:34 INFO - Contents: 14:32:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51df3e242fb1cb6ade6c68171c30154e35b2b582b623adc4abfb7458a9525ea5eb4b1a2c9bd5b6e2f41f39c2762598a0092b12dba350b5abef6acd71854fe809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/227f6c3194bc4f86396728cbf91e22b0d0100812437cabeb35ebcdef06b631e105835c3994099849861220318f630b8208a7110a6ae59ceee17e064c7ce9128a"} 14:32:34 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:34 INFO - Copying logs to upload dir... 14:32:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:32:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.039951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-15 14:32:34.805210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 14:32:34.808414) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 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/51df3e242fb1cb6ade6c68171c30154e35b2b582b623adc4abfb7458a9525ea5eb4b1a2c9bd5b6e2f41f39c2762598a0092b12dba350b5abef6acd71854fe809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/227f6c3194bc4f86396728cbf91e22b0d0100812437cabeb35ebcdef06b631e105835c3994099849861220318f630b8208a7110a6ae59ceee17e064c7ce9128a"} build_url:https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/fZtETBhbTyGNvklezjGNYg/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/51df3e242fb1cb6ade6c68171c30154e35b2b582b623adc4abfb7458a9525ea5eb4b1a2c9bd5b6e2f41f39c2762598a0092b12dba350b5abef6acd71854fe809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/227f6c3194bc4f86396728cbf91e22b0d0100812437cabeb35ebcdef06b631e105835c3994099849861220318f630b8208a7110a6ae59ceee17e064c7ce9128a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 14:32:34.833340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:32:34.833661) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1b9da9da7504fe468691862d000001b9-1458076222.612746-1593444383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 14:32:34.917107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 14:32:34.917445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 14:32:34.917748) ========= ========= Total master_lag: 0.28 =========