builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1458833479.21 results: success (0) buildid: 20160324053021 builduid: 404126014d4e44a8b1f39f487355f040 revision: 2af30898a2a826d1f6277178e155efcf77d3ca32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.205385) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.205854) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.206151) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005164 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.228431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.228755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.258996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.259421) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027168 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.306450) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.306948) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.307480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.307794) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 08:31:19-- 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% 26.0M=0s 2016-03-24 08:31:19 (26.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.475762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.476076) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089724 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:19.754046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 08:31:19.754362) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2af30898a2a826d1f6277178e155efcf77d3ca32 --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 2af30898a2a826d1f6277178e155efcf77d3ca32 --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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 08:31:19,829 truncating revision to first 12 chars 2016-03-24 08:31:19,829 Setting DEBUG logging. 2016-03-24 08:31:19,829 attempt 1/10 2016-03-24 08:31:19,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2af30898a2a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 08:31:20,665 unpacking tar archive at: fx-team-2af30898a2a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.109267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 08:31:20.877982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:20.878376) ========= echo 2af30898a2a826d1f6277178e155efcf77d3ca32 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2af30898a2a826d1f6277178e155efcf77d3ca32'] 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2af30898a2a826d1f6277178e155efcf77d3ca32 program finished with exit code 0 elapsedTime=0.003387 script_repo_revision: '2af30898a2a826d1f6277178e155efcf77d3ca32' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:20.926494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:20.926862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 08:31:20.938399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-24 08:31:20.938719) ========= /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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:31:21 INFO - MultiFileLogger online at 20160324 08:31:21 in /builds/slave/test-pgo 08:31:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:31:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:31:21 INFO - {'append_to_log': False, 08:31:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:31:21 INFO - 'blob_upload_branch': 'Fx-Team', 08:31:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:31:21 INFO - 'branch': 'Fx-Team', 08:31:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:21 INFO - 'config_files': ('talos/linux_config.py',), 08:31:21 INFO - 'default_actions': ('clobber', 08:31:21 INFO - 'read-buildbot-config', 08:31:21 INFO - 'download-and-extract', 08:31:21 INFO - 'populate-webroot', 08:31:21 INFO - 'create-virtualenv', 08:31:21 INFO - 'install', 08:31:21 INFO - 'run-tests'), 08:31:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:21 INFO - 'download_minidump_stackwalk': True, 08:31:21 INFO - 'download_symbols': 'ondemand', 08:31:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:21 INFO - 'installer_path': 'installer.exe', 08:31:21 INFO - 'log_level': 'info', 08:31:21 INFO - 'log_name': 'talos', 08:31:21 INFO - 'log_to_console': True, 08:31:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:31:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:31:21 INFO - 'opt_config_files': (), 08:31:21 INFO - 'pip_index': False, 08:31:21 INFO - 'sps_profile': False, 08:31:21 INFO - 'sps_profile_interval': 0, 08:31:21 INFO - 'suite': 'dromaeojs', 08:31:21 INFO - 'system_bits': '32', 08:31:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:21 INFO - 'title': 'talos-linux64-ix-016', 08:31:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:21 INFO - 'use_talos_json': True, 08:31:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:31:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:21 INFO - 'work_dir': 'build'} 08:31:21 INFO - ##### 08:31:21 INFO - ##### Running clobber step. 08:31:21 INFO - ##### 08:31:21 INFO - Running pre-action listener: _resource_record_pre_action 08:31:21 INFO - Running main action method: clobber 08:31:21 INFO - rmtree: /builds/slave/test-pgo/build 08:31:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:31:22 INFO - Running post-action listener: _resource_record_post_action 08:31:22 INFO - ##### 08:31:22 INFO - ##### Running read-buildbot-config step. 08:31:22 INFO - ##### 08:31:22 INFO - Running pre-action listener: _resource_record_pre_action 08:31:22 INFO - Running main action method: read_buildbot_config 08:31:22 INFO - Using buildbot properties: 08:31:22 INFO - { 08:31:22 INFO - "project": "", 08:31:22 INFO - "product": "firefox", 08:31:22 INFO - "script_repo_revision": "production", 08:31:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:31:22 INFO - "repository": "", 08:31:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:31:22 INFO - "buildid": "20160324053021", 08:31:22 INFO - "pgo_build": "True", 08:31:22 INFO - "basedir": "/builds/slave/test-pgo", 08:31:22 INFO - "buildnumber": 1028, 08:31:22 INFO - "slavename": "talos-linux64-ix-016", 08:31:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:31:22 INFO - "platform": "ubuntu64_hw", 08:31:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:31:22 INFO - "branch": "fx-team", 08:31:22 INFO - "repo_path": "integration/fx-team", 08:31:22 INFO - "revision": "2af30898a2a826d1f6277178e155efcf77d3ca32", 08:31:22 INFO - "stage_platform": "linux64-pgo", 08:31:22 INFO - "builduid": "404126014d4e44a8b1f39f487355f040", 08:31:22 INFO - "slavebuilddir": "test" 08:31:22 INFO - } 08:31:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:31:22 INFO - Running post-action listener: _resource_record_post_action 08:31:22 INFO - ##### 08:31:22 INFO - ##### Running download-and-extract step. 08:31:22 INFO - ##### 08:31:22 INFO - Running pre-action listener: _resource_record_pre_action 08:31:22 INFO - Running main action method: download_and_extract 08:31:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:31: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')]} 08:31:22 INFO - https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:31:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:31:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:31:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:23 INFO - Downloaded 1361 bytes. 08:31:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:31:23 INFO - Using the following test package requirements: 08:31:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:31:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:31:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'jsshell-linux-x86_64.zip'], 08:31:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:31:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:31:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:31:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:31:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:31:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:23 INFO - https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:28 INFO - Downloaded 23633976 bytes. 08:31:28 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'] 08:31:28 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 08:31:29 INFO - Return code: 0 08:31:29 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 08:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:29 INFO - https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:31 INFO - Downloaded 23633976 bytes. 08:31:31 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'] 08:31:31 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 08:31:32 INFO - Return code: 0 08:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:32 INFO - https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:33 INFO - Downloaded 10847187 bytes. 08:31:33 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'] 08:31:33 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 08:31:33 INFO - Return code: 0 08:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:33 INFO - https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQNL3q48QjefBTQe8h7Ytg/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 08:31:35 INFO - Downloaded 57728927 bytes. 08:31:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:31:35 INFO - mkdir: /builds/slave/test-pgo/properties 08:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:31:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:31:35 INFO - Contents: 08:31:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:31:35 INFO - Running post-action listener: _resource_record_post_action 08:31:35 INFO - Running post-action listener: set_extra_try_arguments 08:31:35 INFO - ##### 08:31:35 INFO - ##### Running populate-webroot step. 08:31:35 INFO - ##### 08:31:35 INFO - Running pre-action listener: _resource_record_pre_action 08:31:35 INFO - Running main action method: populate_webroot 08:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:35 INFO - '--tppagecycles', 08:31:35 INFO - '7'], 08:31:35 INFO - 'tests': ['tsvgm']}}, 08:31:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:31:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:31:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'tests': ['damp', 'tps']}, 08:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['damp', 'tps']}, 08:31:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:35 INFO - 'other': {'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'other_l64': {'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'other_nol64': {'tests': ['a11yr', 08:31:35 INFO - 'ts_paint', 08:31:35 INFO - 'tpaint', 08:31:35 INFO - 'sessionrestore', 08:31:35 INFO - 'sessionrestore_no_auto_restore', 08:31:35 INFO - 'tabpaint']}, 08:31:35 INFO - 'svgr': {'tests': ['tsvgx', 08:31:35 INFO - 'tsvgr_opacity', 08:31:35 INFO - 'tart', 08:31:35 INFO - 'tscrollx', 08:31:35 INFO - 'cart']}, 08:31:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['tsvgx', 08:31:35 INFO - 'tsvgr_opacity', 08:31:35 INFO - 'tart', 08:31:35 INFO - 'tscrollx', 08:31:35 INFO - 'cart']}, 08:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'tests': ['tp5o']}, 08:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'talos_options': ['--e10s'], 08:31:35 INFO - 'tests': ['tp5o']}, 08:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'talos_options': ['--xperf_path', 08:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:35 INFO - 'tests': ['tp5n']}, 08:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:35 INFO - 'talos_options': ['--e10s', 08:31:35 INFO - '--xperf_path', 08:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:35 INFO - 'tests': ['tp5n']}}, 08:31:35 INFO - 'talos.zip': {'path': '', 08:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:35 INFO - Running post-action listener: _resource_record_post_action 08:31:35 INFO - ##### 08:31:35 INFO - ##### Running create-virtualenv step. 08:31:35 INFO - ##### 08:31:35 INFO - Running pre-action listener: _resource_record_pre_action 08:31:35 INFO - Running main action method: create_virtualenv 08:31:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:31:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:31:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:35 INFO - Using real prefix '/usr' 08:31:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:38 INFO - Installing pip.................done. 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:31: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 pip>=1.5 08:31:38 INFO - Using env: {'DISPLAY': ':0', 08:31:38 INFO - 'HOME': '/home/cltbld', 08:31:38 INFO - 'LANG': 'en_US.UTF-8', 08:31:38 INFO - 'LANGUAGE': 'en_US:en', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MAIL': '/var/mail/cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SHLVL': '1', 08:31:38 INFO - 'TERM': 'linux', 08:31:38 INFO - 'TMOUT': '86400', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - '_': '/tools/buildbot/bin/python'} 08:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:31:38 INFO - Cleaning up... 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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', '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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:31: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 psutil>=0.7.1 08:31:38 INFO - Using env: {'DISPLAY': ':0', 08:31:38 INFO - 'HOME': '/home/cltbld', 08:31:38 INFO - 'LANG': 'en_US.UTF-8', 08:31:38 INFO - 'LANGUAGE': 'en_US:en', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MAIL': '/var/mail/cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SHLVL': '1', 08:31:38 INFO - 'TERM': 'linux', 08:31:38 INFO - 'TMOUT': '86400', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - '_': '/tools/buildbot/bin/python'} 08:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:38 INFO - Downloading/unpacking psutil>=0.7.1 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:40 INFO - Installing collected packages: psutil 08:31:40 INFO - Running setup.py install for psutil 08:31:40 INFO - building 'psutil._psutil_linux' extension 08:31:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:31:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:31:41 INFO - building 'psutil._psutil_posix' extension 08:31:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:31:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:41 INFO - Successfully installed psutil 08:31:41 INFO - Cleaning up... 08:31:41 INFO - Return code: 0 08:31:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:41 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:31:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:31:41 INFO - Using env: {'DISPLAY': ':0', 08:31:41 INFO - 'HOME': '/home/cltbld', 08:31:41 INFO - 'LANG': 'en_US.UTF-8', 08:31:41 INFO - 'LANGUAGE': 'en_US:en', 08:31:41 INFO - 'LOGNAME': 'cltbld', 08:31:41 INFO - 'MAIL': '/var/mail/cltbld', 08:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:41 INFO - 'MOZ_NO_REMOTE': '1', 08:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:41 INFO - 'NO_EM_RESTART': '1', 08:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:41 INFO - 'SHELL': '/bin/bash', 08:31:41 INFO - 'SHLVL': '1', 08:31:41 INFO - 'TERM': 'linux', 08:31:41 INFO - 'TMOUT': '86400', 08:31:41 INFO - 'USER': 'cltbld', 08:31:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:41 INFO - '_': '/tools/buildbot/bin/python'} 08:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:31:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:31:43 INFO - Installing collected packages: mozsystemmonitor 08:31:43 INFO - Running setup.py install for mozsystemmonitor 08:31:43 INFO - Successfully installed mozsystemmonitor 08:31:43 INFO - Cleaning up... 08:31:43 INFO - Return code: 0 08:31:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:31:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:31:43 INFO - Using env: {'DISPLAY': ':0', 08:31:43 INFO - 'HOME': '/home/cltbld', 08:31:43 INFO - 'LANG': 'en_US.UTF-8', 08:31:43 INFO - 'LANGUAGE': 'en_US:en', 08:31:43 INFO - 'LOGNAME': 'cltbld', 08:31:43 INFO - 'MAIL': '/var/mail/cltbld', 08:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:43 INFO - 'MOZ_NO_REMOTE': '1', 08:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:43 INFO - 'NO_EM_RESTART': '1', 08:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:43 INFO - 'SHELL': '/bin/bash', 08:31:43 INFO - 'SHLVL': '1', 08:31:43 INFO - 'TERM': 'linux', 08:31:43 INFO - 'TMOUT': '86400', 08:31:43 INFO - 'USER': 'cltbld', 08:31:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:43 INFO - '_': '/tools/buildbot/bin/python'} 08:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:31:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:46 INFO - Downloading docopt-0.6.1.tar.gz 08:31:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:46 INFO - Running setup.py install for blobuploader 08:31:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:31:46 INFO - Running setup.py install for requests 08:31:46 INFO - Running setup.py install for docopt 08:31:47 INFO - Successfully installed blobuploader requests docopt 08:31:47 INFO - Cleaning up... 08:31:47 INFO - Return code: 0 08:31:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:47 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:31:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:47 INFO - Using env: {'DISPLAY': ':0', 08:31:47 INFO - 'HOME': '/home/cltbld', 08:31:47 INFO - 'LANG': 'en_US.UTF-8', 08:31:47 INFO - 'LANGUAGE': 'en_US:en', 08:31:47 INFO - 'LOGNAME': 'cltbld', 08:31:47 INFO - 'MAIL': '/var/mail/cltbld', 08:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:47 INFO - 'MOZ_NO_REMOTE': '1', 08:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:47 INFO - 'NO_EM_RESTART': '1', 08:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:47 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:47 INFO - 'SHELL': '/bin/bash', 08:31:47 INFO - 'SHLVL': '1', 08:31:47 INFO - 'TERM': 'linux', 08:31:47 INFO - 'TMOUT': '86400', 08:31:47 INFO - 'USER': 'cltbld', 08:31:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:47 INFO - '_': '/tools/buildbot/bin/python'} 08:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:47 INFO - Running setup.py (path:/tmp/pip-GoLdFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:47 INFO - Running setup.py (path:/tmp/pip-7bo8LV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:47 INFO - Running setup.py (path:/tmp/pip-C5NVB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:47 INFO - Running setup.py (path:/tmp/pip-BdaPsV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:47 INFO - Running setup.py (path:/tmp/pip-dumAZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:47 INFO - Running setup.py (path:/tmp/pip-GMyGhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:47 INFO - Running setup.py (path:/tmp/pip-bbRcml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:47 INFO - Running setup.py (path:/tmp/pip-lfbRsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:47 INFO - Running setup.py (path:/tmp/pip-Tmi6a9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:47 INFO - Running setup.py (path:/tmp/pip-Kg6BTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:48 INFO - Running setup.py (path:/tmp/pip-N2QBpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:48 INFO - Running setup.py (path:/tmp/pip-ygMipx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:48 INFO - Running setup.py (path:/tmp/pip-fNUq2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:48 INFO - Running setup.py (path:/tmp/pip-mvKz0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:48 INFO - Running setup.py (path:/tmp/pip-m8EvPg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:48 INFO - Running setup.py (path:/tmp/pip-XHbAQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:48 INFO - Running setup.py (path:/tmp/pip-upyYXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:48 INFO - Running setup.py install for manifestparser 08:31:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:31:48 INFO - Running setup.py install for mozcrash 08:31:48 INFO - Running setup.py install for mozdebug 08:31:48 INFO - Running setup.py install for mozdevice 08:31:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:31:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:31:48 INFO - Running setup.py install for mozfile 08:31:49 INFO - Running setup.py install for mozhttpd 08:31:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for mozinfo 08:31:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for mozInstall 08:31:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for mozleak 08:31:49 INFO - Running setup.py install for mozlog 08:31:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for moznetwork 08:31:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for mozprocess 08:31:49 INFO - Running setup.py install for mozprofile 08:31:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:31:49 INFO - Running setup.py install for mozrunner 08:31:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:31:50 INFO - Running setup.py install for mozscreenshot 08:31:50 INFO - Running setup.py install for moztest 08:31:50 INFO - Running setup.py install for mozversion 08:31:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:31:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:50 INFO - Cleaning up... 08:31:50 INFO - Return code: 0 08:31:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:50 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:31:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:50 INFO - Using env: {'DISPLAY': ':0', 08:31:50 INFO - 'HOME': '/home/cltbld', 08:31:50 INFO - 'LANG': 'en_US.UTF-8', 08:31:50 INFO - 'LANGUAGE': 'en_US:en', 08:31:50 INFO - 'LOGNAME': 'cltbld', 08:31:50 INFO - 'MAIL': '/var/mail/cltbld', 08:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:50 INFO - 'MOZ_NO_REMOTE': '1', 08:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:50 INFO - 'NO_EM_RESTART': '1', 08:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:50 INFO - 'SHELL': '/bin/bash', 08:31:50 INFO - 'SHLVL': '1', 08:31:50 INFO - 'TERM': 'linux', 08:31:50 INFO - 'TMOUT': '86400', 08:31:50 INFO - 'USER': 'cltbld', 08:31:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:50 INFO - '_': '/tools/buildbot/bin/python'} 08:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:50 INFO - Running setup.py (path:/tmp/pip-A0kBaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:50 INFO - Running setup.py (path:/tmp/pip-5jmPoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:50 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)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:50 INFO - Running setup.py (path:/tmp/pip-5i2GU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:50 INFO - Running setup.py (path:/tmp/pip-M7QWrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:50 INFO - Running setup.py (path:/tmp/pip-zjxStg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:50 INFO - Running setup.py (path:/tmp/pip-CKY03r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:51 INFO - Running setup.py (path:/tmp/pip-_8OHZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:51 INFO - Running setup.py (path:/tmp/pip-Q3s7Ac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:51 INFO - Running setup.py (path:/tmp/pip-SQaklq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:51 INFO - Running setup.py (path:/tmp/pip-GalMJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:51 INFO - Running setup.py (path:/tmp/pip-bcUkPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:51 INFO - Running setup.py (path:/tmp/pip-FLQdqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:51 INFO - Running setup.py (path:/tmp/pip-JLNuUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:51 INFO - Running setup.py (path:/tmp/pip-IfCXdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:51 INFO - Running setup.py (path:/tmp/pip-NOOD5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:51 INFO - Running setup.py (path:/tmp/pip-jbIdB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:31:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:51 INFO - Running setup.py (path:/tmp/pip-QOYCXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:31:51 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)) 08:31:51 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)) 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - Downloading blessings-1.6.tar.gz 08:31:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:53 INFO - Installing collected packages: blessings 08:31:53 INFO - Running setup.py install for blessings 08:31:53 INFO - Successfully installed blessings 08:31:53 INFO - Cleaning up... 08:31:53 INFO - Return code: 0 08:31:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:31:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:31:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:31:54 INFO - Reading from file tmpfile_stdout 08:31:54 INFO - Current package versions: 08:31:54 INFO - argparse == 1.2.1 08:31:54 INFO - blessings == 1.6 08:31:54 INFO - blobuploader == 1.2.4 08:31:54 INFO - docopt == 0.6.1 08:31:54 INFO - manifestparser == 1.1 08:31:54 INFO - mozInstall == 1.12 08:31:54 INFO - mozcrash == 0.17 08:31:54 INFO - mozdebug == 0.1 08:31:54 INFO - mozdevice == 0.48 08:31:54 INFO - mozfile == 1.2 08:31:54 INFO - mozhttpd == 0.7 08:31:54 INFO - mozinfo == 0.9 08:31:54 INFO - mozleak == 0.1 08:31:54 INFO - mozlog == 3.1 08:31:54 INFO - moznetwork == 0.27 08:31:54 INFO - mozprocess == 0.22 08:31:54 INFO - mozprofile == 0.28 08:31:54 INFO - mozrunner == 6.11 08:31:54 INFO - mozscreenshot == 0.1 08:31:54 INFO - mozsystemmonitor == 0.0 08:31:54 INFO - moztest == 0.7 08:31:54 INFO - mozversion == 1.4 08:31:54 INFO - psutil == 3.1.1 08:31:54 INFO - requests == 1.2.3 08:31:54 INFO - wsgiref == 0.1.2 08:31:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:54 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:31:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:54 INFO - Using env: {'DISPLAY': ':0', 08:31:54 INFO - 'HOME': '/home/cltbld', 08:31:54 INFO - 'LANG': 'en_US.UTF-8', 08:31:54 INFO - 'LANGUAGE': 'en_US:en', 08:31:54 INFO - 'LOGNAME': 'cltbld', 08:31:54 INFO - 'MAIL': '/var/mail/cltbld', 08:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:54 INFO - 'MOZ_NO_REMOTE': '1', 08:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:54 INFO - 'NO_EM_RESTART': '1', 08:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:54 INFO - 'SHELL': '/bin/bash', 08:31:54 INFO - 'SHLVL': '1', 08:31:54 INFO - 'TERM': 'linux', 08:31:54 INFO - 'TMOUT': '86400', 08:31:54 INFO - 'USER': 'cltbld', 08:31:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:54 INFO - '_': '/tools/buildbot/bin/python'} 08:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:31:54 INFO - Cleaning up... 08:31:54 INFO - Return code: 0 08:31:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:54 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:31:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:31:54 INFO - Using env: {'DISPLAY': ':0', 08:31:54 INFO - 'HOME': '/home/cltbld', 08:31:54 INFO - 'LANG': 'en_US.UTF-8', 08:31:54 INFO - 'LANGUAGE': 'en_US:en', 08:31:54 INFO - 'LOGNAME': 'cltbld', 08:31:54 INFO - 'MAIL': '/var/mail/cltbld', 08:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:54 INFO - 'MOZ_NO_REMOTE': '1', 08:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:54 INFO - 'NO_EM_RESTART': '1', 08:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:54 INFO - 'SHELL': '/bin/bash', 08:31:54 INFO - 'SHLVL': '1', 08:31:54 INFO - 'TERM': 'linux', 08:31:54 INFO - 'TMOUT': '86400', 08:31:54 INFO - 'USER': 'cltbld', 08:31:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:54 INFO - '_': '/tools/buildbot/bin/python'} 08:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:54 INFO - Downloading/unpacking jsonschema 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:56 INFO - Downloading/unpacking functools32 (from jsonschema) 08:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:56 INFO - warning: no files found matching '*.txt' 08:31:56 INFO - no previously-included directories found matching 'build' 08:31:56 INFO - no previously-included directories found matching 'dist' 08:31:56 INFO - no previously-included directories found matching '.git*' 08:31:56 INFO - Installing collected packages: jsonschema, functools32 08:31:56 INFO - Running setup.py install for functools32 08:31:56 INFO - warning: no files found matching '*.txt' 08:31:56 INFO - no previously-included directories found matching 'build' 08:31:56 INFO - no previously-included directories found matching 'dist' 08:31:56 INFO - no previously-included directories found matching '.git*' 08:31:56 INFO - Successfully installed jsonschema functools32 08:31:56 INFO - Cleaning up... 08:31:56 INFO - Return code: 0 08:31:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 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 0x7f769cb03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, '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': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:31:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:31:56 INFO - Using env: {'DISPLAY': ':0', 08:31:56 INFO - 'HOME': '/home/cltbld', 08:31:56 INFO - 'LANG': 'en_US.UTF-8', 08:31:56 INFO - 'LANGUAGE': 'en_US:en', 08:31:56 INFO - 'LOGNAME': 'cltbld', 08:31:56 INFO - 'MAIL': '/var/mail/cltbld', 08:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:56 INFO - 'MOZ_NO_REMOTE': '1', 08:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:56 INFO - 'NO_EM_RESTART': '1', 08:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:56 INFO - 'SHELL': '/bin/bash', 08:31:56 INFO - 'SHLVL': '1', 08:31:56 INFO - 'TERM': 'linux', 08:31:56 INFO - 'TMOUT': '86400', 08:31:56 INFO - 'USER': 'cltbld', 08:31:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:56 INFO - '_': '/tools/buildbot/bin/python'} 08:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:57 INFO - Downloading/unpacking flake8 08:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:31:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:31:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:31:59 INFO - no previously-included directories found matching 'docs/_build' 08:31:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:31:59 INFO - Running setup.py install for pep8 08:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:31:59 INFO - no previously-included directories found matching 'docs/_build' 08:31:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:31:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:31:59 INFO - Cleaning up... 08:31:59 INFO - Return code: 0 08:31:59 INFO - Running post-action listener: _resource_record_post_action 08:31:59 INFO - Running post-action listener: _start_resource_monitoring 08:31:59 INFO - Starting resource monitoring. 08:31:59 INFO - ##### 08:31:59 INFO - ##### Running install step. 08:31:59 INFO - ##### 08:31:59 INFO - Running pre-action listener: _resource_record_pre_action 08:31:59 INFO - Running main action method: install 08:31:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:31:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:32:00 INFO - Reading from file tmpfile_stdout 08:32:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:32:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:32:00 INFO - Reading from file tmpfile_stdout 08:32:00 INFO - Output received: 08:32:00 INFO - Usage: mozinstall [options] installer 08:32:00 INFO - Options: 08:32:00 INFO - -h, --help show this help message and exit 08:32:00 INFO - -d DEST, --destination=DEST 08:32:00 INFO - Directory to install application into. [default: 08:32:00 INFO - "/builds/slave/test-pgo"] 08:32:00 INFO - --app=APP Application being installed. [default: firefox] 08:32:00 INFO - mkdir: /builds/slave/test-pgo/build/application 08:32:00 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'] 08:32:00 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 08:32:16 INFO - Reading from file tmpfile_stdout 08:32:16 INFO - Output received: 08:32:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:32:16 INFO - Running post-action listener: _resource_record_post_action 08:32:16 INFO - ##### 08:32:16 INFO - ##### Running run-tests step. 08:32:16 INFO - ##### 08:32:16 INFO - Running pre-action listener: _resource_record_pre_action 08:32:16 INFO - Running main action method: run_tests 08:32:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:32:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:32:16 INFO - Python 2.7.3 08:32:16 INFO - Return code: 0 08:32:16 INFO - grabbing minidump binary from tooltool 08:32: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')]} 08:32:16 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 0x12f41d0>, '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 0x12f7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f7be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:32:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:32:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:32:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:16 INFO - Return code: 0 08:32:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:32:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:32:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:32:17 INFO - Return code: 0 08:32:17 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/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:32:17 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/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:32:17 INFO - Using env: {'DISPLAY': ':0', 08:32:17 INFO - 'HOME': '/home/cltbld', 08:32:17 INFO - 'LANG': 'en_US.UTF-8', 08:32:17 INFO - 'LANGUAGE': 'en_US:en', 08:32:17 INFO - 'LOGNAME': 'cltbld', 08:32:17 INFO - 'MAIL': '/var/mail/cltbld', 08:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:17 INFO - 'MOZ_NO_REMOTE': '1', 08:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:17 INFO - 'NO_EM_RESTART': '1', 08:32:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:17 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:32:17 INFO - 'SHELL': '/bin/bash', 08:32:17 INFO - 'SHLVL': '1', 08:32:17 INFO - 'TERM': 'linux', 08:32:17 INFO - 'TMOUT': '86400', 08:32:17 INFO - 'USER': 'cltbld', 08:32:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458832754.812795-299185808', 08:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:17 INFO - '_': '/tools/buildbot/bin/python'} 08:32:17 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/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:32:17 INFO - mozversion application_buildid: 20160324053021 08:32:17 INFO - mozversion application_changeset: 2af30898a2a826d1f6277178e155efcf77d3ca32 08:32:17 INFO - mozversion application_display_name: Nightly 08:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:17 INFO - mozversion application_name: Firefox 08:32:17 INFO - mozversion application_remotingname: firefox 08:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:32:17 INFO - mozversion application_vendor: Mozilla 08:32:17 INFO - mozversion application_version: 48.0a1 08:32:17 INFO - mozversion platform_buildid: 20160324053021 08:32:17 INFO - mozversion platform_changeset: 2af30898a2a826d1f6277178e155efcf77d3ca32 08:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:32:17 INFO - mozversion platform_version: 48.0a1 08:32:17 INFO - using testdate: 1458833537 08:32:17 INFO - actual date: 1458833537 08:32:17 INFO - starting webserver on 'localhost:37060' 08:32:17 INFO - SUITE-START | Running 2 tests 08:32:17 INFO - TEST-START | dromaeo_css 08:32:17 INFO - operating with platform_type : linux_ 08:32:17 INFO - Initialising browser for dromaeo_css test... 08:32:17 INFO - TEST-INFO | started process 23776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCdlNsN/profile http://localhost:37060/getInfo.html) 08:32:22 INFO - PROCESS | 23776 | __metrics Screen width/height:1600/1200 08:32:22 INFO - PROCESS | 23776 | colorDepth:24 08:32:22 INFO - PROCESS | 23776 | Browser inner width/height: 1024/697 08:32:22 INFO - PROCESS | 23776 | __metrics 08:32:23 ERROR - PROCESS | 23776 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:32:23 INFO - TEST-INFO | 23776: exit 0 08:32:23 INFO - Browser initialized. 08:32:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:32:23 INFO - TEST-INFO | started process 23870 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCdlNsN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:35 INFO - PROCESS | 23870 | RSS: Main: 156160000 08:32:35 INFO - PROCESS | 23870 | 08:33:27 INFO - PROCESS | 23870 | 1458833607223 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:35:33 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37060/tests/dromaeo/cssquery-ext.html) 08:35:34 INFO - PROCESS | 23870 | RSS: Main: 255860736 08:35:34 INFO - PROCESS | 23870 | 08:38:36 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-ext.html (next: http://localhost:37060/tests/dromaeo/cssquery-jquery.html) 08:38:37 INFO - PROCESS | 23870 | RSS: Main: 235839488 08:38:37 INFO - PROCESS | 23870 | 08:41:39 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37060/tests/dromaeo/cssquery-mootools.html) 08:41:39 INFO - PROCESS | 23870 | RSS: Main: 241668096 08:41:39 INFO - PROCESS | 23870 | 08:44:41 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37060/tests/dromaeo/cssquery-prototype.html) 08:44:42 INFO - PROCESS | 23870 | RSS: Main: 218005504 08:44:42 INFO - PROCESS | 23870 | 08:47:44 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37060/tests/dromaeo/cssquery-yui.html) 08:47:45 INFO - PROCESS | 23870 | RSS: Main: 219897856 08:47:45 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | Cycle 1(1): loaded http://localhost:37060/tests/dromaeo/cssquery-yui.html (next: http://localhost:37060/tests/dromaeo/cssquery-dojo.html) 08:50:47 INFO - PROCESS | 23870 | RSS: Main: 267628544 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | __start_tp_report 08:50:47 INFO - PROCESS | 23870 | _x_x_mozilla_page_load 08:50:47 INFO - PROCESS | 23870 | _x_x_mozilla_page_load_details 08:50:47 INFO - PROCESS | 23870 | |i|pagename|runs| 08:50:47 INFO - PROCESS | 23870 | |0;dojo.html;2946;2964.733174014341;3010.9913179085006;3011.7891747577664;3052.8168309901403;5005.424376196738;5044.974775126128;5064.493550644934;5104.515071068247;5110.591152707784;5067;5093.949060509403;5105.872353191172;5158.380994280682;5163.922541161885;4500.5949464548185;4592.311153326994;4671.556202160807;4725.905481890377;4751.619870410359;4505.279155335147;4776.498467660897;4780.020095880336;4787.6648634595595;4789.568938795508;4620.930686039712;4630.351750754863;4645.396098507206;4653;4716.2218233991525;4598.287265473823;4606.723596584216;4609.631229501631;4611.100835337111;4615.630749540029;4536.432945881765;4584.4957054723955;4587.632989360844;4590.08198360326;4646.721196728207;4970.179920313144;4977.278294647292;5000;5005.699658020494;5021.221710634857;5381.650192737459;5383.300170977787;5390.137577987503;5397.757100930428;5441.401445840955;5383.784648614051;5407.459254074601;5514.80698175562;5612;5614.831555053355;5104.617153713486;5133.794648214104;5134.127198376285;5136.640435169502;5143.408508021588;5615.185798059259;5618.747156377973;5620.353659329229;5625.971870140705;5629.408912064257;5293.153095504701;5404.83785486436;5431.321084864392;5495.285612870382;5497.39528651848;5423.430539793344;5435.2934118564335;5440.836774896759;5450.4549545045975;5452.04589196889;5311.150215965505;5420.13277875538;5421.186821976657;5430.864228394243;5474.835754927359;5492.505674489315;5514.91727624086;5544.029794785896;5562.527185189304;5581.944180558143;4197.643200328006;4217.514985776614;4221.02916329246;4226.661867050629;4260;3679.4112941929698;3744.794036328028;3789.5642001170218;3804.1821008483307;3809.3333666608232;5179.093658609729;5203.973980130075;5240.842774716688;5242.659227150223;5277.1292736698015;5479.287692599936;5495.780168793283;5501.367342755554;5501.642393244426;5503.2020357048;5105.770240339194;5156.329677141947;5205.089109405839;5210.192420174879;5232.502912223409;4642.396488456479;4712.717236965793;4728.527147285244;4769.213079841857;4769.928451073237;5717.056685646905;5717.3996730342715;5725.8568535786935;5728.112142617901;5776.335721392094;5302.2576839241765;5473.452654734654;5535.501804837584;5535.916961245504;5536.833894983157;5671.914921276101;5689.6586204827845;5692.345380281321;5706.942930570641;5740.6268592541355;5416.783328666809;5433.402325744244;5433.56531477473;5434.456554344692;5436.918446223389;5370.9731451342495;5501.174823776466;5525.530329922001;5563.360213575491;5634.915476267777;5341;5341.41244463101;5341.813036543703;5355.812546560852;5375.838724838261;5289.285946397187;5290.947090529199;5293.417724050274;5298.443663415286;5342.679439233659;5075.949240507695;5225.294585230945;5234.18870075139;5335.226392173191;5337.359516858002;5371.060064488621;5394.352677678704;5396.325459317585;5397.541208997279;5398.1093119634825;5246.291750613618;5283.075461794094;5298.841034768809;5303.257543943774;5340.5994550408095 08:50:47 INFO - PROCESS | 23870 | |1;ext.html;551.5823814215739;556.4741319453116;582.775631381918;595.9362537869902;600.5345856960857;38240.23519529611;38881.41677874834;38885.61114388855;38945.41581876267;38958;40346.59653403465;40795.38806917899;40863.387049194214;40868.79565602175;40888;8552.572371381437;8718.956405217965;8719.346049046315;8738.606762695694;8740.694075707352;8604.35467339952;8741.650333986632;8744.256738177262;8748.737537873874;8756.299496040301;8962.238209752179;8980.057094005133;9035.728928132166;9047.411918225327;9060.592273347715;8911.55442227886;9014.188723014895;9017.864732029026;9022.052684468103;9028.961669408003;8765.254953328975;8875.955620221923;8887.066857979948;8891.644334226623;8892.466452012835;41190.588094118975;41543.792281038404;41561.792191038854;41630.375544366856;41685.37471937924;3394.8472318745717;3395.8811441599423;3609.8014609196484;3615.0420138663276;3698.33429982603;31893.202669933205;31912.361752765046;32449.837750811093;32553.186170345693;32805.52375143124;4161.4382058422025;4199.202151591218;4216.2832318505925;4244.575542445762;4270.850520231777;310960;313203;313214;313817;313956;50956.235656465185;58166.70916645474;58626.413735862094;59093.40906590965;59130;60457.69771151116;61170.69414652987;61189;61219.693901530205;61249;17018.829811701726;17321.4803555891;17324.220410081576;17331.30674772995;17332.740008899877;11766.529338826522;11771.058315334752;11795.823062654066;11821.408929553489;11847.229930054518;18747.81252187488;19112.904435477732;19176.520586985436;19217.51956201106;19237.326693565657;7637.579933103621;7822.4524283299625;7891.842163156704;8022.919770802334;8064.8387032259025;963.3016063354012;1029.4080903480378;1085.6688709943544;1182.722060315825;1194.8267501212276;30615.175856501744;31676.36647267042;32035.3982300884;32201.838990804896;32376;1089.967300980972;1109.1200415295996;1124.7694222684331;1156.5720683347215;1191.124523475245;16310.266038028318;16596;16604.335826567043;16739.581510462336;16774.58063548421;383781;386692;387819;388719;389053;50582.74708626433;50764;50888.49111508911;50900.236496452584;51018.48981510212;1299.5061876487064;1356.8439629442742;1374.883134933542;1448.8261408630822;1490.172954010513;28708;28838.42323153567;30091.247718806328;30904.69095309108;32553.674463255065;45278.773606131756;50982;52081.218781719064;52107.478925210264;52155;234246;235031;236059;236149;237356;30599.2350191247;31160;34341.656583434844;34402.48396274008;35134.64865351314;42066.158676826904;42189;42369.576304236565;42813;42836.14327713366;34785.30429391449;35801.64198357983;36108.63891361053;36352;36644.81677591595;35694.82152589324;35740.28519429545;35833.849969001945;36108.09729756672;36225.45661815128;36688.26623467569;36699.63300366962;39358.60641393549;45988.77005614951;48523;41610.791866159074;42066.57933420749;43283.56716432796;43551;43862.02620882132;32829.34341313112;33277.16807079745;33312.81705101648;33382.99851004376;33527 08:50:47 INFO - PROCESS | 23870 | |2;jquery.html;363.2462640021955;369.2780613899826;373.1101323343824;373.3745975491052;377.4376179492556;16989.150542472875;17319.740203896938;17912.104394780275;17989.730154047684;17997;16447.2598733057;17248;17256;17407;17424.390146344882;4789.976050119744;5009.02324046811;5010.173321401964;5010.6993580385115;5011.523905229015;3792.9620703792884;4907.8773030674165;5427.104527752916;5640.956423061747;5651.519620832214;5647.068233741427;5655.4910058094765;5658.236138121342;5668.093105103184;5678.545716342683;5378.381486129106;5620.1288800236025;5632.831015069554;5636.126400407943;5636.915446268309;5412.161115027177;5414.431484694129;5419.376771671269;5420.972895135538;5422.48486393792;14447.85552144486;16112;21610.35168944934;21611.67582486264;21690.24084157047;2171.685105659686;2258.6499092640665;2328.7904088631935;2369.616319375276;2457.103157347573;9565.521723913776;9727.513624318755;12776.233425994471;13330.600081997556;13483.19100853952;1964.5972575622106;1998.8500862435376;2033.6847788592793;2041.8361533925668;2064.556120434114;70160;73658.63170684165;74047.62976185138;74214.99999999946;74921.62539187324;10180.185585153169;10280.177585793119;10595.311304765166;10643.042126208524;10758.677239682822;13529.729405411837;13598.796018059737;13617.727645447036;13622.93188534051;13629.04596678223;7893.460775148791;8225.506469611842;8274.338052955749;8335.749927502186;8340.749777506684;8212;8259.545724985184;8264.8347033059;8373.623186956602;8376.706815261437;4408.867733967922;4419.756913369795;4498.707584007029;4527.547245275512;4567.840125595588;1783.8840475369059;1815.900125493084;1831.7710286214224;1849.805770394116;1909.2649330008046;957.3777044920857;966.6181858165985;1039.73486760877;1053.3890343600692;1057.3655806516028;16238.75641865373;16738.58153546171;17260.136993150292;17374.739378909326;17746.20142093609;956.8134213828237;960.644561512231;984.3896783993827;1043.2905624175482;1060.5439660945713;9414.388064775767;9885.604575817031;9989.900100998897;10070.827689277854;10084;487184;499560;504303;506178;510118;80886;80917.59541202257;84712.57643711742;85665.57167214125;85684;976.7509285132388;1065.073386154051;1101.1576144249655;1121.9326840389604;1122.6351435783404;10445.895541044796;10616.628418005334;10854.728631784268;10889;11187.049100826522;32414.351712965137;36362.81818590996;36732.632673672924;36771.26457470889;36844;51907;52262;52577.21134183067;52647.73676131748;52739.47260527499;11006.614768483065;11025.17311201647;11338;11788;11993.760124797629;13984.44062237499;14036.649083772987;14096.436142554183;14291.142531448146;14294.499692510712;12158.939205303917;12221.144519883523;12276.079294052803;12311.13822032485;12449.564265251034;12117.69705757328;12255.080868934687;12272.509099635914;12350.567730129762;12493.687657808627;12264.202826816228;12421.757824217506;12717.80923286133;12891.613251602466;12914.024399356436;11859.229150105215;12077.57728479499;12088.939555302519;12315.384230788246;12387.442565084413;12290.20113692607;12370.690732731753;12591;12723.93638031841;12815.16701414405 08:50:47 INFO - PROCESS | 23870 | |3;mootools.html;1337.324651051219;1446.5877224990877;1450.9709805803884;1598.9120598367092;1775.6004898897759;7688.615569221538;7790.026246719161;7795.454318197729;7799.142094369615;7810.1408845027145;7478.476506644537;7651.043619547557;7651.579163146025;7660.693572257103;7664.540127592349;2029.7158397824317;2085.7705652378227;2254.1546919905036;2274.9886250568766;2308.5613733390687;2275.0899640143907;2280.3614987803358;2285.3029825903095;2286.5198308355266;2288.5079707862806;2202.702635144259;2205.3273751505785;2300.2754132448226;2302.666113413554;2303.2284184798114;2255.109231853425;2265.3543740034092;2271.761465046171;2291.5989701802287;2315.120254303354;2275.2150508074687;2283.8629682218952;2306.9653955190684;2309.515001849614;2312.814974802012;8122.106568277485;8201.30288925442;8201.384896132755;8202.220789025034;8204.302634276033;4815.0610630926985;4917.4344950330815;4943.6539442239055;4944.975275123637;4945.9258111128365;3409.1136304560746;3421.059208717598;3472.878449254289;3556.1287484566187;3559.0568499347437;1182.4165141527965;1182.5447202826888;1188.3998580716768;1214.2228973456995;1222.2177806204036;11272.718182045432;11288.096952243883;11334.376609286486;11339.37633430161;11360.715982100432;4204.726692764961;4312.331588603772;4315.266404711207;4365.825366985285;4366.126774645084;9643.180329671915;9645.276604254708;9666.371685840399;9689.660861869941;9697.369670971364;4910.90178196434;4920.581750551243;4926.729029903389;4927.211646136601;4929.876753081202;4013.257547353749;4382.561743825592;4510.391097201901;4516.141933032779;4522.525134860858;3663.8900832975055;3757.8496860125833;3790.0714324990554;3791.9810400947817;3876.4379165020914;1186.4008675618757;1195.0797885628017;1195.6950977500683;1198.7422704118655;1207.7463732616072;1335.2722766092502;1342.5099838558856;1347.9797803032961;1405.1709491400122;1407.0010292692098;7352.852942941111;7584.241575842371;7584.696612135453;7595.772126836204;7596.3922886168975;441.53197610532294;444.97107688000176;454.75670516273635;456.8127067902144;459.7976890168315;6009.939900600938;6031.909521357183;6032.517398608101;6072.332043475214;6079.3008803988105;9024.278057755495;9527.951925288213;9534.570944307523;9541.618335266512;9554.283428742872;9386.95306523463;9489.952550237205;9492.762680932894;9500.714978550655;9521.095495927875;7292.70829166838;7550.093988721389;7560.58416787082;7567.848643027219;7572.545647261182;7176.641167941478;7236.674349654383;7247.891281630675;7257.49197556166;7264.89102663471;8473.49159050459;8508.659653613786;8546.78633034179;8602.225799678059;8611.440256383315;8618.913810862063;8784.209421152127;8868.512231827312;8879.911200888168;8932.86600701003;6177.81466556004;6324.747010119728;6558.540902136805;6868.759593414206;6940.444764418733;7393.667284972296;7412.703491860265;7415.073115860518;7443.627818609156;7457.850842983218;6681.398674119158;6817.079694241413;6818.590884546943;6894.551854129466;6917.13535808024;6613.338666133348;6635.2037755469655;6684.532082754161;6704.765333213314;6757.459403247827;7042.436605071684;7131.0729605151;7244.058272424551;7255.383292419992;7258.782236532912;6578.473722102125;6623.138991931018;6643.036759669917;6643.50173736962;6646.700898459678;6589.604623722592;6675.165604299463;6688.264290927897;6699.39705426514;6702.262751097473 08:50:47 INFO - PROCESS | 23870 | |4;prototype.html;318.9330240649463;325.5247338885228;327.8409971163986;331.9900402987908;334.75061079495777;5912.320083190434;5940.465358117768;5948.226730525036;5977.372375900533;5997.970010149943;5896.469317761401;5920.407959204077;5929.318128415233;5940.168376427293;5941.554383421249;4292.527821939584;4399.098184872094;4495.325701144821;4522.8417005404735;4534.274516077428;4544.613707834838;4567.246404343296;4567.748773817439;4570.291604801261;4571.5657012583915;4512.887177820548;4515.593596576307;4516.2548179550495;4526.321051842234;4526.660500462462;4317.309230523117;4390.648748100144;4480.708753930984;4482.193205223059;4500.8649740507835;3966.0084978755312;3966.7421617594764;3971.4837071180564;3971.8411263549424;3973.781442020688;5703.629264097862;5705.65766054034;5707.6575405475805;5710.600257981943;5713.914291285634;5289.841304760864;5291.761870715827;5292.126799078147;5294.841154765363;5296.205569164617;6227.595206311576;6232.968835155841;6237.6257424554215;6238.906416403757;6239.968800156015;4177.289860723654;4309.4397728295435;4321.891952701208;4421.557844215553;4432.556744325574;6479.481641468718;6508.869822603521;6545.476361891037;6549.0831283619855;6556.606603603799;4401.273789824707;4401.537838526909;4406.603405693439;4409.977950110229;4411.00752330723;4461.709988850715;4461.7992190351515;4464.866054018385;4467.6202522785925;4467.709598876063;5171.3535808024;5174.990876779068;5177.326947496801;5179.326687530597;5184.714840683799;6143.201383820164;6312.8421789454715;6315.652639104894;6324.272708638566;6327.209098862642;1527.8243002054905;1537.085434166669;1543.0664448008793;1546.7834503169565;1548.0634216298977;985.3299756165876;1012.9696109116591;1020.3469779341227;1021.7190272675074;1027.6916924922493;6052.273727152769;6148.354422785633;6150.169727086875;6161.599496032743;6161.72272247741;6569.408753212234;6589.374009469093;6590.835229119214;6591.307912669196;6593.571417857824;6157.353477884847;6176.536759743038;6176.567640265228;6192.938070619326;6199.132121502993;3478.4608385700258;3512.3150985557572;3516.841742121611;3519.542459480251;3526.876559320463;6668.099806526154;6723.562968407038;6799.4900382471515;6811.863762724718;6828.214755303204;6631.635260060743;6640.8671826563195;6642.468602511787;6646.734130634721;6660.533762636569;6767.458603311723;6767.593944363354;6772.864542709217;6777.796666100025;6780;6535.738570457319;6537.1174891389055;6537.803865884031;6546.18172728409;6552.8361790955605;6251.9687401562705;6406.967965160145;6432.09950606906;6432.742690292524;6463.289038205699;6763.797086087426;6774.8645027100165;6789;6823.38589526945;6840.6921688525135;4407.4711034674765;4431.158079964796;4440.845380201106;4444.511103778646;4450.666200034945;6533.705983230671;6537.378948999837;6537.967310163419;6543.770968016097;6545.050967609765;6157.96921015392;6337.017762246859;6366.586171898812;6376.266729326187;6385.8722825544155;6333.303336633059;6340.968295158495;6361.045843123568;6368.840778980562;6369.267534233622;6221;6244.188255526752;6246.281677607133;6249.25008998923;6256;6356.936430635635;6396.648184349905;6408.839779005562;6417.903731443938;6427.58220715652;5972.8805423892145;6081.5134789217645;6256.249250090018;6258.280297765815;6262.997920332907 08:50:47 INFO - PROCESS | 23870 | |5;yui.html;716.7742161219219;732.4653003307582;740.300416106779;758.9468737188396;852;14617.342219600117;14693.33879975401;14757.704845903088;14777.48278810242;14844.554663360117;13068;13141.54004609839;13154.276514791683;13160.276184809856;13183.143095698773;645.1484041065795;791.996040019802;814.975550733476;823.1069289820551;823.2919689067397;810.9959450202741;814.2142832166958;819.1194465949098;820.3109388113983;824.3858325547476;685.2975699907585;857.2070834478114;857.3184318466803;861.9741407757746;861.9827603447959;841.7474757572734;850.3877208409934;856.4047986649281;856.7772379181396;857.2970164465141;621.5897507644978;621.9751209951596;622.0948519903575;622.2532960447481;622.7664625765339;14093.224872632001;14170.07894486855;14170.504032358922;14171.149731016068;14189.148651080968;12560.623181304576;12825.16636418639;12915.547955821501;13339.466421343135;13441.32793360338;10931.289466184673;11001.339919604769;11098.500567474402;11193.49629266685;11281.49233284496;3743.1765011697385;3775.5846856846;3780.924381512382;3836.1943991761764;3883.631055049794;52777.2083418749;53774.19338709922;57334.71332643352;58929.7053514734;59093;10143.18854491639;10639.574417023232;10794.622188223375;10930.890691093146;11062.502187401586;19268.614627707648;19375.51561210981;19393.806061939482;19450.319238826574;19475.8052419474;7915.456695506419;7924.286814186751;7945.920540794518;7971.043474782947;8085.393595480363;4255.8084886180195;4271.957280427156;4327.653787696977;4330.328799036154;4396.120775844844;3380.4929260611107;3411.5906091269208;3415.334009868052;3419.3161367726057;3471.4272145096284;565.4591238874035;581.5115303145378;581.8516278349078;591.3583761618606;594.7442599682091;533.6717918480107;600.2856600645218;668.2281964331205;726.5059759363578;726.8001299642641;7819.218078192135;8007.159248278964;8237.917620823835;8293.295069919004;8316.334693224528;672.6502218846173;690.8790961581703;695.7495301691387;708.4580296073508;721.2895298131336;3788.6021967693546;3854.3811599128435;3965.861194858224;3981.8606348777653;4018.9598104018587;68400;68849;69012;69141;69275.3072469279;58950;62113.68943155255;62881;63016.05475917865;63328;55406.72296638491;55546.44453555493;55829;56601.71699141478;57489.712551436976;7744.419168562267;8039.995000624922;8123.7156699515235;8318.584070796314;8357.122502137432;39880.60119398769;40198.39702404525;40955.38566921558;41331;41359.586404136775;49250;51576.48423515717;53516.46483535115;53755.19367209573;54033.18950215828;11699.824502632297;11753.823692644446;12191.268523888595;12309.322987235788;12552.623421297376;10043.849342260019;11685.883141168819;12033.217840840318;12106.636800895987;12674.62547512492;11522.769544608893;11609.883901161218;11638.88361116412;11689.473973671034;11763.117766167401;11730.413479326171;11869.76260474803;11994.460249288628;12035.398230088636;12264.570740024057;11719.414029298672;11896.107791915814;11925.344106073902;11927.880721192678;11934.641960741192;10223.437710925971;10309.639162629272;10382.584696612052;10412.114970227616;10600.734981625521;9992.250581206294;10271.383716977005;10286.897131028594;10302.639407620996;10320.174386049248 08:50:47 INFO - PROCESS | 23870 | __end_tp_report 08:50:47 INFO - PROCESS | 23870 | __start_cc_report 08:50:47 INFO - PROCESS | 23870 | _x_x_mozilla_cycle_collect,790 08:50:47 INFO - PROCESS | 23870 | __end_cc_report 08:50:47 INFO - PROCESS | 23870 | __startTimestamp1458834647687__endTimestamp 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | ------- Summary: start ------- 08:50:47 INFO - PROCESS | 23870 | Number of tests: 6 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#0] dojo.html Cycles:165 Average:5089.08 Median:5293.15 stddev:576.52 (10.9%) stddev-sans-first:553.23 08:50:47 INFO - PROCESS | 23870 | Values: 2946.0 2964.7 3011.0 3011.8 3052.8 5005.4 5045.0 5064.5 5104.5 5110.6 5067.0 5093.9 5105.9 5158.4 5163.9 4500.6 4592.3 4671.6 4725.9 4751.6 4505.3 4776.5 4780.0 4787.7 4789.6 4620.9 4630.4 4645.4 4653.0 4716.2 4598.3 4606.7 4609.6 4611.1 4615.6 4536.4 4584.5 4587.6 4590.1 4646.7 4970.2 4977.3 5000.0 5005.7 5021.2 5381.7 5383.3 5390.1 5397.8 5441.4 5383.8 5407.5 5514.8 5612.0 5614.8 5104.6 5133.8 5134.1 5136.6 5143.4 5615.2 5618.7 5620.4 5626.0 5629.4 5293.2 5404.8 5431.3 5495.3 5497.4 5423.4 5435.3 5440.8 5450.5 5452.0 5311.2 5420.1 5421.2 5430.9 5474.8 5492.5 5514.9 5544.0 5562.5 5581.9 4197.6 4217.5 4221.0 4226.7 4260.0 3679.4 3744.8 3789.6 3804.2 3809.3 5179.1 5204.0 5240.8 5242.7 5277.1 5479.3 5495.8 5501.4 5501.6 5503.2 5105.8 5156.3 5205.1 5210.2 5232.5 4642.4 4712.7 4728.5 4769.2 4769.9 5717.1 5717.4 5725.9 5728.1 5776.3 5302.3 5473.5 5535.5 5535.9 5536.8 5671.9 5689.7 5692.3 5706.9 5740.6 5416.8 5433.4 5433.6 5434.5 5436.9 5371.0 5501.2 5525.5 5563.4 5634.9 5341.0 5341.4 5341.8 5355.8 5375.8 5289.3 5290.9 5293.4 5298.4 5342.7 5075.9 5225.3 5234.2 5335.2 5337.4 5371.1 5394.4 5396.3 5397.5 5398.1 5246.3 5283.1 5298.8 5303.3 5340.6 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#1] ext.html Cycles:180 Average:49025.98 Median:213800.21 stddev:83354.90 (39.0%) stddev-sans-first:83509.27 08:50:47 INFO - PROCESS | 23870 | Values: 551.6 556.5 582.8 595.9 600.5 38240.2 38881.4 38885.6 38945.4 38958.0 40346.6 40795.4 40863.4 40868.8 40888.0 8552.6 8719.0 8719.3 8738.6 8740.7 8604.4 8741.7 8744.3 8748.7 8756.3 8962.2 8980.1 9035.7 9047.4 9060.6 8911.6 9014.2 9017.9 9022.1 9029.0 8765.3 8876.0 8887.1 8891.6 8892.5 41190.6 41543.8 41561.8 41630.4 41685.4 3394.8 3395.9 3609.8 3615.0 3698.3 31893.2 31912.4 32449.8 32553.2 32805.5 4161.4 4199.2 4216.3 4244.6 4270.9 310960.0 313203.0 313214.0 313817.0 313956.0 50956.2 58166.7 58626.4 59093.4 59130.0 60457.7 61170.7 61189.0 61219.7 61249.0 17018.8 17321.5 17324.2 17331.3 17332.7 11766.5 11771.1 11795.8 11821.4 11847.2 18747.8 19112.9 19176.5 19217.5 19237.3 7637.6 7822.5 7891.8 8022.9 8064.8 963.3 1029.4 1085.7 1182.7 1194.8 30615.2 31676.4 32035.4 32201.8 32376.0 1090.0 1109.1 1124.8 1156.6 1191.1 16310.3 16596.0 16604.3 16739.6 16774.6 383781.0 386692.0 387819.0 388719.0 389053.0 50582.7 50764.0 50888.5 50900.2 51018.5 1299.5 1356.8 1374.9 1448.8 1490.2 28708.0 28838.4 30091.2 30904.7 32553.7 45278.8 50982.0 52081.2 52107.5 52155.0 234246.0 235031.0 236059.0 236149.0 237356.0 30599.2 31160.0 34341.7 34402.5 35134.6 42066.2 42189.0 42369.6 42813.0 42836.1 34785.3 35801.6 36108.6 36352.0 36644.8 35694.8 35740.3 35833.8 36108.1 36225.5 36688.3 36699.6 39358.6 45988.8 48523.0 41610.8 42066.6 43283.6 43551.0 43862.0 32829.3 33277.2 33312.8 33383.0 33527.0 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#2] jquery.html Cycles:180 Average:28307.19 Median:11837.45 stddev:82292.45 (695.2%) stddev-sans-first:82496.55 08:50:47 INFO - PROCESS | 23870 | Values: 363.2 369.3 373.1 373.4 377.4 16989.2 17319.7 17912.1 17989.7 17997.0 16447.3 17248.0 17256.0 17407.0 17424.4 4790.0 5009.0 5010.2 5010.7 5011.5 3793.0 4907.9 5427.1 5641.0 5651.5 5647.1 5655.5 5658.2 5668.1 5678.5 5378.4 5620.1 5632.8 5636.1 5636.9 5412.2 5414.4 5419.4 5421.0 5422.5 14447.9 16112.0 21610.4 21611.7 21690.2 2171.7 2258.6 2328.8 2369.6 2457.1 9565.5 9727.5 12776.2 13330.6 13483.2 1964.6 1998.9 2033.7 2041.8 2064.6 70160.0 73658.6 74047.6 74215.0 74921.6 10180.2 10280.2 10595.3 10643.0 10758.7 13529.7 13598.8 13617.7 13622.9 13629.0 7893.5 8225.5 8274.3 8335.7 8340.7 8212.0 8259.5 8264.8 8373.6 8376.7 4408.9 4419.8 4498.7 4527.5 4567.8 1783.9 1815.9 1831.8 1849.8 1909.3 957.4 966.6 1039.7 1053.4 1057.4 16238.8 16738.6 17260.1 17374.7 17746.2 956.8 960.6 984.4 1043.3 1060.5 9414.4 9885.6 9989.9 10070.8 10084.0 487184.0 499560.0 504303.0 506178.0 510118.0 80886.0 80917.6 84712.6 85665.6 85684.0 976.8 1065.1 1101.2 1121.9 1122.6 10445.9 10616.6 10854.7 10889.0 11187.0 32414.4 36362.8 36732.6 36771.3 36844.0 51907.0 52262.0 52577.2 52647.7 52739.5 11006.6 11025.2 11338.0 11788.0 11993.8 13984.4 14036.6 14096.4 14291.1 14294.5 12158.9 12221.1 12276.1 12311.1 12449.6 12117.7 12255.1 12272.5 12350.6 12493.7 12264.2 12421.8 12717.8 12891.6 12914.0 11859.2 12077.6 12088.9 12315.4 12387.4 12290.2 12370.7 12591.0 12723.9 12815.2 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#3] mootools.html Cycles:180 Average:5556.14 Median:6251.28 stddev:2909.83 (46.5%) stddev-sans-first:2900.71 08:50:47 INFO - PROCESS | 23870 | Values: 1337.3 1446.6 1451.0 1598.9 1775.6 7688.6 7790.0 7795.5 7799.1 7810.1 7478.5 7651.0 7651.6 7660.7 7664.5 2029.7 2085.8 2254.2 2275.0 2308.6 2275.1 2280.4 2285.3 2286.5 2288.5 2202.7 2205.3 2300.3 2302.7 2303.2 2255.1 2265.4 2271.8 2291.6 2315.1 2275.2 2283.9 2307.0 2309.5 2312.8 8122.1 8201.3 8201.4 8202.2 8204.3 4815.1 4917.4 4943.7 4945.0 4945.9 3409.1 3421.1 3472.9 3556.1 3559.1 1182.4 1182.5 1188.4 1214.2 1222.2 11272.7 11288.1 11334.4 11339.4 11360.7 4204.7 4312.3 4315.3 4365.8 4366.1 9643.2 9645.3 9666.4 9689.7 9697.4 4910.9 4920.6 4926.7 4927.2 4929.9 4013.3 4382.6 4510.4 4516.1 4522.5 3663.9 3757.8 3790.1 3792.0 3876.4 1186.4 1195.1 1195.7 1198.7 1207.7 1335.3 1342.5 1348.0 1405.2 1407.0 7352.9 7584.2 7584.7 7595.8 7596.4 441.5 445.0 454.8 456.8 459.8 6009.9 6031.9 6032.5 6072.3 6079.3 9024.3 9528.0 9534.6 9541.6 9554.3 9387.0 9490.0 9492.8 9500.7 9521.1 7292.7 7550.1 7560.6 7567.8 7572.5 7176.6 7236.7 7247.9 7257.5 7264.9 8473.5 8508.7 8546.8 8602.2 8611.4 8618.9 8784.2 8868.5 8879.9 8932.9 6177.8 6324.7 6558.5 6868.8 6940.4 7393.7 7412.7 7415.1 7443.6 7457.9 6681.4 6817.1 6818.6 6894.6 6917.1 6613.3 6635.2 6684.5 6704.8 6757.5 7042.4 7131.1 7244.1 7255.4 7258.8 6578.5 6623.1 6643.0 6643.5 6646.7 6589.6 6675.2 6688.3 6699.4 6702.3 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#4] prototype.html Cycles:180 Average:5275.83 Median:6066.89 stddev:1613.52 (26.6%) stddev-sans-first:1574.57 08:50:47 INFO - PROCESS | 23870 | Values: 318.9 325.5 327.8 332.0 334.8 5912.3 5940.5 5948.2 5977.4 5998.0 5896.5 5920.4 5929.3 5940.2 5941.6 4292.5 4399.1 4495.3 4522.8 4534.3 4544.6 4567.2 4567.7 4570.3 4571.6 4512.9 4515.6 4516.3 4526.3 4526.7 4317.3 4390.6 4480.7 4482.2 4500.9 3966.0 3966.7 3971.5 3971.8 3973.8 5703.6 5705.7 5707.7 5710.6 5713.9 5289.8 5291.8 5292.1 5294.8 5296.2 6227.6 6233.0 6237.6 6238.9 6240.0 4177.3 4309.4 4321.9 4421.6 4432.6 6479.5 6508.9 6545.5 6549.1 6556.6 4401.3 4401.5 4406.6 4410.0 4411.0 4461.7 4461.8 4464.9 4467.6 4467.7 5171.4 5175.0 5177.3 5179.3 5184.7 6143.2 6312.8 6315.7 6324.3 6327.2 1527.8 1537.1 1543.1 1546.8 1548.1 985.3 1013.0 1020.3 1021.7 1027.7 6052.3 6148.4 6150.2 6161.6 6161.7 6569.4 6589.4 6590.8 6591.3 6593.6 6157.4 6176.5 6176.6 6192.9 6199.1 3478.5 3512.3 3516.8 3519.5 3526.9 6668.1 6723.6 6799.5 6811.9 6828.2 6631.6 6640.9 6642.5 6646.7 6660.5 6767.5 6767.6 6772.9 6777.8 6780.0 6535.7 6537.1 6537.8 6546.2 6552.8 6252.0 6407.0 6432.1 6432.7 6463.3 6763.8 6774.9 6789.0 6823.4 6840.7 4407.5 4431.2 4440.8 4444.5 4450.7 6533.7 6537.4 6538.0 6543.8 6545.1 6158.0 6337.0 6366.6 6376.3 6385.9 6333.3 6341.0 6361.0 6368.8 6369.3 6221.0 6244.2 6246.3 6249.3 6256.0 6356.9 6396.6 6408.8 6417.9 6427.6 5972.9 6081.5 6256.2 6258.3 6263.0 08:50:47 INFO - PROCESS | 23870 | 08:50:47 INFO - PROCESS | 23870 | [#5] yui.html Cycles:180 Average:15533.05 Median:4299.81 stddev:19221.30 (447.0%) stddev-sans-first:19243.02 08:50:47 INFO - PROCESS | 23870 | Values: 716.8 732.5 740.3 758.9 852.0 14617.3 14693.3 14757.7 14777.5 14844.6 13068.0 13141.5 13154.3 13160.3 13183.1 645.1 792.0 815.0 823.1 823.3 811.0 814.2 819.1 820.3 824.4 685.3 857.2 857.3 862.0 862.0 841.7 850.4 856.4 856.8 857.3 621.6 622.0 622.1 622.3 622.8 14093.2 14170.1 14170.5 14171.1 14189.1 12560.6 12825.2 12915.5 13339.5 13441.3 10931.3 11001.3 11098.5 11193.5 11281.5 3743.2 3775.6 3780.9 3836.2 3883.6 52777.2 53774.2 57334.7 58929.7 59093.0 10143.2 10639.6 10794.6 10930.9 11062.5 19268.6 19375.5 19393.8 19450.3 19475.8 7915.5 7924.3 7945.9 7971.0 8085.4 4255.8 4272.0 4327.7 4330.3 4396.1 3380.5 3411.6 3415.3 3419.3 3471.4 565.5 581.5 581.9 591.4 594.7 533.7 600.3 668.2 726.5 726.8 7819.2 8007.2 8237.9 8293.3 8316.3 672.7 690.9 695.7 708.5 721.3 3788.6 3854.4 3965.9 3981.9 4019.0 68400.0 68849.0 69012.0 69141.0 69275.3 58950.0 62113.7 62881.0 63016.1 63328.0 55406.7 55546.4 55829.0 56601.7 57489.7 7744.4 8040.0 8123.7 8318.6 8357.1 39880.6 40198.4 40955.4 41331.0 41359.6 49250.0 51576.5 53516.5 53755.2 54033.2 11699.8 11753.8 12191.3 12309.3 12552.6 10043.8 11685.9 12033.2 12106.6 12674.6 11522.8 11609.9 11638.9 11689.5 11763.1 11730.4 11869.8 11994.5 12035.4 12264.6 11719.4 11896.1 11925.3 11927.9 11934.6 10223.4 10309.6 10382.6 10412.1 10600.7 9992.3 10271.4 10286.9 10302.6 10320.2 08:50:47 INFO - PROCESS | 23870 | -------- Summary: end -------- 08:50:47 INFO - PROCESS | 23870 | 08:50:48 INFO - TEST-INFO | 23870: exit 0 08:50:48 INFO - TEST-OK | dromaeo_css | took 1110512ms 08:50:48 INFO - TEST-START | kraken 08:50:48 INFO - operating with platform_type : linux_ 08:50:48 INFO - Initialising browser for kraken test... 08:50:48 INFO - TEST-INFO | started process 24061 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJdG2UZ/profile http://localhost:37060/getInfo.html) 08:50:52 INFO - PROCESS | 24061 | __metrics Screen width/height:1600/1200 08:50:52 INFO - PROCESS | 24061 | colorDepth:24 08:50:52 INFO - PROCESS | 24061 | Browser inner width/height: 1024/697 08:50:52 INFO - PROCESS | 24061 | __metrics 08:50:53 ERROR - PROCESS | 24061 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:50:54 INFO - TEST-INFO | 24061: exit 0 08:50:54 INFO - Browser initialized. 08:50:54 INFO - Running cycle 1/1 for kraken test... 08:50:54 INFO - TEST-INFO | started process 24144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJdG2UZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:06 INFO - PROCESS | 24144 | RSS: Main: 156258304 08:51:06 INFO - PROCESS | 24144 | 08:51:08 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37060/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:09 INFO - PROCESS | 24144 | RSS: Main: 199262208 08:51:09 INFO - PROCESS | 24144 | 08:51:11 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37060/tests/kraken/driver.html?testName=audio-dft) 08:51:12 INFO - PROCESS | 24144 | RSS: Main: 188006400 08:51:12 INFO - PROCESS | 24144 | 08:51:15 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37060/tests/kraken/driver.html?testName=audio-fft) 08:51:15 INFO - PROCESS | 24144 | RSS: Main: 172212224 08:51:15 INFO - PROCESS | 24144 | 08:51:17 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37060/tests/kraken/driver.html?testName=audio-oscillator) 08:51:18 INFO - PROCESS | 24144 | RSS: Main: 174034944 08:51:18 INFO - PROCESS | 24144 | 08:51:20 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:21 INFO - PROCESS | 24144 | RSS: Main: 174821376 08:51:21 INFO - PROCESS | 24144 | 08:51:24 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37060/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:24 INFO - PROCESS | 24144 | RSS: Main: 175853568 08:51:24 INFO - PROCESS | 24144 | 08:51:28 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37060/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:28 INFO - PROCESS | 24144 | RSS: Main: 175960064 08:51:28 INFO - PROCESS | 24144 | 08:51:31 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37060/tests/kraken/driver.html?testName=json-parse-financial) 08:51:32 INFO - PROCESS | 24144 | RSS: Main: 177340416 08:51:32 INFO - PROCESS | 24144 | 08:51:33 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:34 INFO - PROCESS | 24144 | RSS: Main: 186961920 08:51:34 INFO - PROCESS | 24144 | 08:51:35 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:36 INFO - PROCESS | 24144 | RSS: Main: 184745984 08:51:36 INFO - PROCESS | 24144 | 08:51:38 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:39 INFO - PROCESS | 24144 | RSS: Main: 195870720 08:51:39 INFO - PROCESS | 24144 | 08:51:41 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:41 INFO - PROCESS | 24144 | RSS: Main: 202416128 08:51:41 INFO - PROCESS | 24144 | 08:51:44 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:45 INFO - PROCESS | 24144 | RSS: Main: 203358208 08:51:45 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | Cycle 1(1): loaded http://localhost:37060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37060/tests/kraken/driver.html?testName=ai-astar) 08:51:46 INFO - PROCESS | 24144 | RSS: Main: 263266304 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | __start_tp_report 08:51:46 INFO - PROCESS | 24144 | _x_x_mozilla_page_load 08:51:46 INFO - PROCESS | 24144 | _x_x_mozilla_page_load_details 08:51:46 INFO - PROCESS | 24144 | |i|pagename|runs| 08:51:46 INFO - PROCESS | 24144 | |0;ai-astar;108;109;106;110;108;112;98;110;109;109 08:51:46 INFO - PROCESS | 24144 | |1;audio-beat-detection;156;122;152;166;132;156;155;127;173;127 08:51:46 INFO - PROCESS | 24144 | |2;audio-dft;163;163;162;159;160;159;161;164;161;161 08:51:46 INFO - PROCESS | 24144 | |3;audio-fft;72;75;95;99;74;72;72;116;104;72 08:51:46 INFO - PROCESS | 24144 | |4;audio-oscillator;92;93;146;93;94;94;148;93;94;145 08:51:46 INFO - PROCESS | 24144 | |5;imaging-gaussian-blur;117;117;117;116;118;117;117;117;117;117 08:51:46 INFO - PROCESS | 24144 | |6;imaging-darkroom;145;145;146;145;145;145;146;145;145;146 08:51:46 INFO - PROCESS | 24144 | |7;imaging-desaturate;96;96;95;95;96;96;96;96;95;95 08:51:46 INFO - PROCESS | 24144 | |8;json-parse-financial;55;56;54;55;53;54;56;62;52;51 08:51:46 INFO - PROCESS | 24144 | |9;json-stringify-tinderbox;60;60;60;61;60;61;60;65;60;61 08:51:46 INFO - PROCESS | 24144 | |10;stanford-crypto-aes;77;79;78;77;79;79;78;79;77;95 08:51:46 INFO - PROCESS | 24144 | |11;stanford-crypto-ccm;112;110;111;107;115;113;122;111;107;115 08:51:46 INFO - PROCESS | 24144 | |12;stanford-crypto-pbkdf2;141;134;140;141;139;132;140;141;138;152 08:51:46 INFO - PROCESS | 24144 | |13;stanford-crypto-sha256-iterative;61;63;65;65;62;62;63;63;62;62 08:51:46 INFO - PROCESS | 24144 | __end_tp_report 08:51:46 INFO - PROCESS | 24144 | __start_cc_report 08:51:46 INFO - PROCESS | 24144 | _x_x_mozilla_cycle_collect,1052 08:51:46 INFO - PROCESS | 24144 | __end_cc_report 08:51:46 INFO - PROCESS | 24144 | __startTimestamp1458834706924__endTimestamp 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | ------- Summary: start ------- 08:51:46 INFO - PROCESS | 24144 | Number of tests: 14 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.81 (3.5%) stddev-sans-first:4.04 08:51:46 INFO - PROCESS | 24144 | Values: 108.0 109.0 106.0 110.0 108.0 112.0 98.0 110.0 109.0 109.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:155.50 stddev:18.06 (11.6%) stddev-sans-first:18.84 08:51:46 INFO - PROCESS | 24144 | Values: 156.0 122.0 152.0 166.0 132.0 156.0 155.0 127.0 173.0 127.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.70 (1.1%) stddev-sans-first:1.69 08:51:46 INFO - PROCESS | 24144 | Values: 163.0 163.0 162.0 159.0 160.0 159.0 161.0 164.0 161.0 161.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#3] audio-fft Cycles:10 Average:85.10 Median:73.00 stddev:16.72 (22.9%) stddev-sans-first:17.04 08:51:46 INFO - PROCESS | 24144 | Values: 72.0 75.0 95.0 99.0 74.0 72.0 72.0 116.0 104.0 72.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:25.64 (27.6%) stddev-sans-first:26.43 08:51:46 INFO - PROCESS | 24144 | Values: 92.0 93.0 146.0 93.0 94.0 94.0 148.0 93.0 94.0 145.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 08:51:46 INFO - PROCESS | 24144 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:51:46 INFO - PROCESS | 24144 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:51:46 INFO - PROCESS | 24144 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:3.01 (5.5%) stddev-sans-first:3.19 08:51:46 INFO - PROCESS | 24144 | Values: 55.0 56.0 54.0 55.0 53.0 54.0 56.0 62.0 52.0 51.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.50 stddev:1.55 (2.6%) stddev-sans-first:1.62 08:51:46 INFO - PROCESS | 24144 | Values: 60.0 60.0 60.0 61.0 60.0 61.0 60.0 65.0 60.0 61.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:5.41 (6.9%) stddev-sans-first:5.64 08:51:46 INFO - PROCESS | 24144 | Values: 77.0 79.0 78.0 77.0 79.0 79.0 78.0 79.0 77.0 95.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:112.50 stddev:4.40 (3.9%) stddev-sans-first:4.66 08:51:46 INFO - PROCESS | 24144 | Values: 112.0 110.0 111.0 107.0 115.0 113.0 122.0 111.0 107.0 115.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:140.50 stddev:5.29 (3.8%) stddev-sans-first:5.59 08:51:46 INFO - PROCESS | 24144 | Values: 141.0 134.0 140.0 141.0 139.0 132.0 140.0 141.0 138.0 152.0 08:51:46 INFO - PROCESS | 24144 | 08:51:46 INFO - PROCESS | 24144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.22 08:51:46 INFO - PROCESS | 24144 | Values: 61.0 63.0 65.0 65.0 62.0 62.0 63.0 63.0 62.0 62.0 08:51:46 INFO - PROCESS | 24144 | -------- Summary: end -------- 08:51:46 INFO - PROCESS | 24144 | 08:51:47 INFO - TEST-INFO | 24144: exit 0 08:51:47 INFO - TEST-OK | kraken | took 59466ms 08:51:47 INFO - SUITE-END | took 1169s 08:51:48 INFO - Completed test suite (00:19:30) 08:51:48 INFO - javascript benchmark 08:51:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2946.0, 2964.733174014341, 3010.9913179085006, 3011.7891747577664, 3052.8168309901403, 5005.424376196738, 5044.974775126128, 5064.493550644934, 5104.515071068247, 5110.591152707784, 5067.0, 5093.949060509403, 5105.872353191172, 5158.380994280682, 5163.922541161885, 4500.5949464548185, 4592.311153326994, 4671.556202160807, 4725.905481890377, 4751.619870410359, 4505.279155335147, 4776.498467660897, 4780.020095880336, 4787.6648634595595, 4789.568938795508, 4620.930686039712, 4630.351750754863, 4645.396098507206, 4653.0, 4716.2218233991525, 4598.287265473823, 4606.723596584216, 4609.631229501631, 4611.100835337111, 4615.630749540029, 4536.432945881765, 4584.4957054723955, 4587.632989360844, 4590.08198360326, 4646.721196728207, 4970.179920313144, 4977.278294647292, 5000.0, 5005.699658020494, 5021.221710634857, 5381.650192737459, 5383.300170977787, 5390.137577987503, 5397.757100930428, 5441.401445840955, 5383.784648614051, 5407.459254074601, 5514.80698175562, 5612.0, 5614.831555053355, 5104.617153713486, 5133.794648214104, 5134.127198376285, 5136.640435169502, 5143.408508021588, 5615.185798059259, 5618.747156377973, 5620.353659329229, 5625.971870140705, 5629.408912064257, 5293.153095504701, 5404.83785486436, 5431.321084864392, 5495.285612870382, 5497.39528651848, 5423.430539793344, 5435.2934118564335, 5440.836774896759, 5450.4549545045975, 5452.04589196889, 5311.150215965505, 5420.13277875538, 5421.186821976657, 5430.864228394243, 5474.835754927359, 5492.505674489315, 5514.91727624086, 5544.029794785896, 5562.527185189304, 5581.944180558143, 4197.643200328006, 4217.514985776614, 4221.02916329246, 4226.661867050629, 4260.0, 3679.4112941929698, 3744.794036328028, 3789.5642001170218, 3804.1821008483307, 3809.3333666608232, 5179.093658609729, 5203.973980130075, 5240.842774716688, 5242.659227150223, 5277.1292736698015, 5479.287692599936, 5495.780168793283, 5501.367342755554, 5501.642393244426, 5503.2020357048, 5105.770240339194, 5156.329677141947, 5205.089109405839, 5210.192420174879, 5232.502912223409, 4642.396488456479, 4712.717236965793, 4728.527147285244, 4769.213079841857, 4769.928451073237, 5717.056685646905, 5717.3996730342715, 5725.8568535786935, 5728.112142617901, 5776.335721392094, 5302.2576839241765, 5473.452654734654, 5535.501804837584, 5535.916961245504, 5536.833894983157, 5671.914921276101, 5689.6586204827845, 5692.345380281321, 5706.942930570641, 5740.6268592541355, 5416.783328666809, 5433.402325744244, 5433.56531477473, 5434.456554344692, 5436.918446223389, 5370.9731451342495, 5501.174823776466, 5525.530329922001, 5563.360213575491, 5634.915476267777, 5341.0, 5341.41244463101, 5341.813036543703, 5355.812546560852, 5375.838724838261, 5289.285946397187, 5290.947090529199, 5293.417724050274, 5298.443663415286, 5342.679439233659, 5075.949240507695, 5225.294585230945, 5234.18870075139, 5335.226392173191, 5337.359516858002, 5371.060064488621, 5394.352677678704, 5396.325459317585, 5397.541208997279, 5398.1093119634825, 5246.291750613618, 5283.075461794094, 5298.841034768809, 5303.257543943774, 5340.5994550408095], "unit": "score", "name": "dojo.html", "value": 5050.638553368417}, {"lowerIsBetter": false, "replicates": [551.5823814215739, 556.4741319453116, 582.775631381918, 595.9362537869902, 600.5345856960857, 38240.23519529611, 38881.41677874834, 38885.61114388855, 38945.41581876267, 38958.0, 40346.59653403465, 40795.38806917899, 40863.387049194214, 40868.79565602175, 40888.0, 8552.572371381437, 8718.956405217965, 8719.346049046315, 8738.606762695694, 8740.694075707352, 8604.35467339952, 8741.650333986632, 8744.256738177262, 8748.737537873874, 8756.299496040301, 8962.238209752179, 8980.057094005133, 9035.728928132166, 9047.411918225327, 9060.592273347715, 8911.55442227886, 9014.188723014895, 9017.864732029026, 9022.052684468103, 9028.961669408003, 8765.254953328975, 8875.955620221923, 8887.066857979948, 8891.644334226623, 8892.466452012835, 41190.588094118975, 41543.792281038404, 41561.792191038854, 41630.375544366856, 41685.37471937924, 3394.8472318745717, 3395.8811441599423, 3609.8014609196484, 3615.0420138663276, 3698.33429982603, 31893.202669933205, 31912.361752765046, 32449.837750811093, 32553.186170345693, 32805.52375143124, 4161.4382058422025, 4199.202151591218, 4216.2832318505925, 4244.575542445762, 4270.850520231777, 310960.0, 313203.0, 313214.0, 313817.0, 313956.0, 50956.235656465185, 58166.70916645474, 58626.413735862094, 59093.40906590965, 59130.0, 60457.69771151116, 61170.69414652987, 61189.0, 61219.693901530205, 61249.0, 17018.829811701726, 17321.4803555891, 17324.220410081576, 17331.30674772995, 17332.740008899877, 11766.529338826522, 11771.058315334752, 11795.823062654066, 11821.408929553489, 11847.229930054518, 18747.81252187488, 19112.904435477732, 19176.520586985436, 19217.51956201106, 19237.326693565657, 7637.579933103621, 7822.4524283299625, 7891.842163156704, 8022.919770802334, 8064.8387032259025, 963.3016063354012, 1029.4080903480378, 1085.6688709943544, 1182.722060315825, 1194.8267501212276, 30615.175856501744, 31676.36647267042, 32035.3982300884, 32201.838990804896, 32376.0, 1089.967300980972, 1109.1200415295996, 1124.7694222684331, 1156.5720683347215, 1191.124523475245, 16310.266038028318, 16596.0, 16604.335826567043, 16739.581510462336, 16774.58063548421, 383781.0, 386692.0, 387819.0, 388719.0, 389053.0, 50582.74708626433, 50764.0, 50888.49111508911, 50900.236496452584, 51018.48981510212, 1299.5061876487064, 1356.8439629442742, 1374.883134933542, 1448.8261408630822, 1490.172954010513, 28708.0, 28838.42323153567, 30091.247718806328, 30904.69095309108, 32553.674463255065, 45278.773606131756, 50982.0, 52081.218781719064, 52107.478925210264, 52155.0, 234246.0, 235031.0, 236059.0, 236149.0, 237356.0, 30599.2350191247, 31160.0, 34341.656583434844, 34402.48396274008, 35134.64865351314, 42066.158676826904, 42189.0, 42369.576304236565, 42813.0, 42836.14327713366, 34785.30429391449, 35801.64198357983, 36108.63891361053, 36352.0, 36644.81677591595, 35694.82152589324, 35740.28519429545, 35833.849969001945, 36108.09729756672, 36225.45661815128, 36688.26623467569, 36699.63300366962, 39358.60641393549, 45988.77005614951, 48523.0, 41610.791866159074, 42066.57933420749, 43283.56716432796, 43551.0, 43862.02620882132, 32829.34341313112, 33277.16807079745, 33312.81705101648, 33382.99851004376, 33527.0], "unit": "score", "name": "ext.html", "value": 19407.719384034805}, {"lowerIsBetter": false, "replicates": [363.2462640021955, 369.2780613899826, 373.1101323343824, 373.3745975491052, 377.4376179492556, 16989.150542472875, 17319.740203896938, 17912.104394780275, 17989.730154047684, 17997.0, 16447.2598733057, 17248.0, 17256.0, 17407.0, 17424.390146344882, 4789.976050119744, 5009.02324046811, 5010.173321401964, 5010.6993580385115, 5011.523905229015, 3792.9620703792884, 4907.8773030674165, 5427.104527752916, 5640.956423061747, 5651.519620832214, 5647.068233741427, 5655.4910058094765, 5658.236138121342, 5668.093105103184, 5678.545716342683, 5378.381486129106, 5620.1288800236025, 5632.831015069554, 5636.126400407943, 5636.915446268309, 5412.161115027177, 5414.431484694129, 5419.376771671269, 5420.972895135538, 5422.48486393792, 14447.85552144486, 16112.0, 21610.35168944934, 21611.67582486264, 21690.24084157047, 2171.685105659686, 2258.6499092640665, 2328.7904088631935, 2369.616319375276, 2457.103157347573, 9565.521723913776, 9727.513624318755, 12776.233425994471, 13330.600081997556, 13483.19100853952, 1964.5972575622106, 1998.8500862435376, 2033.6847788592793, 2041.8361533925668, 2064.556120434114, 70160.0, 73658.63170684165, 74047.62976185138, 74214.99999999946, 74921.62539187324, 10180.185585153169, 10280.177585793119, 10595.311304765166, 10643.042126208524, 10758.677239682822, 13529.729405411837, 13598.796018059737, 13617.727645447036, 13622.93188534051, 13629.04596678223, 7893.460775148791, 8225.506469611842, 8274.338052955749, 8335.749927502186, 8340.749777506684, 8212.0, 8259.545724985184, 8264.8347033059, 8373.623186956602, 8376.706815261437, 4408.867733967922, 4419.756913369795, 4498.707584007029, 4527.547245275512, 4567.840125595588, 1783.8840475369059, 1815.900125493084, 1831.7710286214224, 1849.805770394116, 1909.2649330008046, 957.3777044920857, 966.6181858165985, 1039.73486760877, 1053.3890343600692, 1057.3655806516028, 16238.75641865373, 16738.58153546171, 17260.136993150292, 17374.739378909326, 17746.20142093609, 956.8134213828237, 960.644561512231, 984.3896783993827, 1043.2905624175482, 1060.5439660945713, 9414.388064775767, 9885.604575817031, 9989.900100998897, 10070.827689277854, 10084.0, 487184.0, 499560.0, 504303.0, 506178.0, 510118.0, 80886.0, 80917.59541202257, 84712.57643711742, 85665.57167214125, 85684.0, 976.7509285132388, 1065.073386154051, 1101.1576144249655, 1121.9326840389604, 1122.6351435783404, 10445.895541044796, 10616.628418005334, 10854.728631784268, 10889.0, 11187.049100826522, 32414.351712965137, 36362.81818590996, 36732.632673672924, 36771.26457470889, 36844.0, 51907.0, 52262.0, 52577.21134183067, 52647.73676131748, 52739.47260527499, 11006.614768483065, 11025.17311201647, 11338.0, 11788.0, 11993.760124797629, 13984.44062237499, 14036.649083772987, 14096.436142554183, 14291.142531448146, 14294.499692510712, 12158.939205303917, 12221.144519883523, 12276.079294052803, 12311.13822032485, 12449.564265251034, 12117.69705757328, 12255.080868934687, 12272.509099635914, 12350.567730129762, 12493.687657808627, 12264.202826816228, 12421.757824217506, 12717.80923286133, 12891.613251602466, 12914.024399356436, 11859.229150105215, 12077.57728479499, 12088.939555302519, 12315.384230788246, 12387.442565084413, 12290.20113692607, 12370.690732731753, 12591.0, 12723.93638031841, 12815.16701414405], "unit": "score", "name": "jquery.html", "value": 8998.401461371224}, {"lowerIsBetter": false, "replicates": [1337.324651051219, 1446.5877224990877, 1450.9709805803884, 1598.9120598367092, 1775.6004898897759, 7688.615569221538, 7790.026246719161, 7795.454318197729, 7799.142094369615, 7810.1408845027145, 7478.476506644537, 7651.043619547557, 7651.579163146025, 7660.693572257103, 7664.540127592349, 2029.7158397824317, 2085.7705652378227, 2254.1546919905036, 2274.9886250568766, 2308.5613733390687, 2275.0899640143907, 2280.3614987803358, 2285.3029825903095, 2286.5198308355266, 2288.5079707862806, 2202.702635144259, 2205.3273751505785, 2300.2754132448226, 2302.666113413554, 2303.2284184798114, 2255.109231853425, 2265.3543740034092, 2271.761465046171, 2291.5989701802287, 2315.120254303354, 2275.2150508074687, 2283.8629682218952, 2306.9653955190684, 2309.515001849614, 2312.814974802012, 8122.106568277485, 8201.30288925442, 8201.384896132755, 8202.220789025034, 8204.302634276033, 4815.0610630926985, 4917.4344950330815, 4943.6539442239055, 4944.975275123637, 4945.9258111128365, 3409.1136304560746, 3421.059208717598, 3472.878449254289, 3556.1287484566187, 3559.0568499347437, 1182.4165141527965, 1182.5447202826888, 1188.3998580716768, 1214.2228973456995, 1222.2177806204036, 11272.718182045432, 11288.096952243883, 11334.376609286486, 11339.37633430161, 11360.715982100432, 4204.726692764961, 4312.331588603772, 4315.266404711207, 4365.825366985285, 4366.126774645084, 9643.180329671915, 9645.276604254708, 9666.371685840399, 9689.660861869941, 9697.369670971364, 4910.90178196434, 4920.581750551243, 4926.729029903389, 4927.211646136601, 4929.876753081202, 4013.257547353749, 4382.561743825592, 4510.391097201901, 4516.141933032779, 4522.525134860858, 3663.8900832975055, 3757.8496860125833, 3790.0714324990554, 3791.9810400947817, 3876.4379165020914, 1186.4008675618757, 1195.0797885628017, 1195.6950977500683, 1198.7422704118655, 1207.7463732616072, 1335.2722766092502, 1342.5099838558856, 1347.9797803032961, 1405.1709491400122, 1407.0010292692098, 7352.852942941111, 7584.241575842371, 7584.696612135453, 7595.772126836204, 7596.3922886168975, 441.53197610532294, 444.97107688000176, 454.75670516273635, 456.8127067902144, 459.7976890168315, 6009.939900600938, 6031.909521357183, 6032.517398608101, 6072.332043475214, 6079.3008803988105, 9024.278057755495, 9527.951925288213, 9534.570944307523, 9541.618335266512, 9554.283428742872, 9386.95306523463, 9489.952550237205, 9492.762680932894, 9500.714978550655, 9521.095495927875, 7292.70829166838, 7550.093988721389, 7560.58416787082, 7567.848643027219, 7572.545647261182, 7176.641167941478, 7236.674349654383, 7247.891281630675, 7257.49197556166, 7264.89102663471, 8473.49159050459, 8508.659653613786, 8546.78633034179, 8602.225799678059, 8611.440256383315, 8618.913810862063, 8784.209421152127, 8868.512231827312, 8879.911200888168, 8932.86600701003, 6177.81466556004, 6324.747010119728, 6558.540902136805, 6868.759593414206, 6940.444764418733, 7393.667284972296, 7412.703491860265, 7415.073115860518, 7443.627818609156, 7457.850842983218, 6681.398674119158, 6817.079694241413, 6818.590884546943, 6894.551854129466, 6917.13535808024, 6613.338666133348, 6635.2037755469655, 6684.532082754161, 6704.765333213314, 6757.459403247827, 7042.436605071684, 7131.0729605151, 7244.058272424551, 7255.383292419992, 7258.782236532912, 6578.473722102125, 6623.138991931018, 6643.036759669917, 6643.50173736962, 6646.700898459678, 6589.604623722592, 6675.165604299463, 6688.264290927897, 6699.39705426514, 6702.262751097473], "unit": "score", "name": "mootools.html", "value": 4490.047442598037}, {"lowerIsBetter": false, "replicates": [318.9330240649463, 325.5247338885228, 327.8409971163986, 331.9900402987908, 334.75061079495777, 5912.320083190434, 5940.465358117768, 5948.226730525036, 5977.372375900533, 5997.970010149943, 5896.469317761401, 5920.407959204077, 5929.318128415233, 5940.168376427293, 5941.554383421249, 4292.527821939584, 4399.098184872094, 4495.325701144821, 4522.8417005404735, 4534.274516077428, 4544.613707834838, 4567.246404343296, 4567.748773817439, 4570.291604801261, 4571.5657012583915, 4512.887177820548, 4515.593596576307, 4516.2548179550495, 4526.321051842234, 4526.660500462462, 4317.309230523117, 4390.648748100144, 4480.708753930984, 4482.193205223059, 4500.8649740507835, 3966.0084978755312, 3966.7421617594764, 3971.4837071180564, 3971.8411263549424, 3973.781442020688, 5703.629264097862, 5705.65766054034, 5707.6575405475805, 5710.600257981943, 5713.914291285634, 5289.841304760864, 5291.761870715827, 5292.126799078147, 5294.841154765363, 5296.205569164617, 6227.595206311576, 6232.968835155841, 6237.6257424554215, 6238.906416403757, 6239.968800156015, 4177.289860723654, 4309.4397728295435, 4321.891952701208, 4421.557844215553, 4432.556744325574, 6479.481641468718, 6508.869822603521, 6545.476361891037, 6549.0831283619855, 6556.606603603799, 4401.273789824707, 4401.537838526909, 4406.603405693439, 4409.977950110229, 4411.00752330723, 4461.709988850715, 4461.7992190351515, 4464.866054018385, 4467.6202522785925, 4467.709598876063, 5171.3535808024, 5174.990876779068, 5177.326947496801, 5179.326687530597, 5184.714840683799, 6143.201383820164, 6312.8421789454715, 6315.652639104894, 6324.272708638566, 6327.209098862642, 1527.8243002054905, 1537.085434166669, 1543.0664448008793, 1546.7834503169565, 1548.0634216298977, 985.3299756165876, 1012.9696109116591, 1020.3469779341227, 1021.7190272675074, 1027.6916924922493, 6052.273727152769, 6148.354422785633, 6150.169727086875, 6161.599496032743, 6161.72272247741, 6569.408753212234, 6589.374009469093, 6590.835229119214, 6591.307912669196, 6593.571417857824, 6157.353477884847, 6176.536759743038, 6176.567640265228, 6192.938070619326, 6199.132121502993, 3478.4608385700258, 3512.3150985557572, 3516.841742121611, 3519.542459480251, 3526.876559320463, 6668.099806526154, 6723.562968407038, 6799.4900382471515, 6811.863762724718, 6828.214755303204, 6631.635260060743, 6640.8671826563195, 6642.468602511787, 6646.734130634721, 6660.533762636569, 6767.458603311723, 6767.593944363354, 6772.864542709217, 6777.796666100025, 6780.0, 6535.738570457319, 6537.1174891389055, 6537.803865884031, 6546.18172728409, 6552.8361790955605, 6251.9687401562705, 6406.967965160145, 6432.09950606906, 6432.742690292524, 6463.289038205699, 6763.797086087426, 6774.8645027100165, 6789.0, 6823.38589526945, 6840.6921688525135, 4407.4711034674765, 4431.158079964796, 4440.845380201106, 4444.511103778646, 4450.666200034945, 6533.705983230671, 6537.378948999837, 6537.967310163419, 6543.770968016097, 6545.050967609765, 6157.96921015392, 6337.017762246859, 6366.586171898812, 6376.266729326187, 6385.8722825544155, 6333.303336633059, 6340.968295158495, 6361.045843123568, 6368.840778980562, 6369.267534233622, 6221.0, 6244.188255526752, 6246.281677607133, 6249.25008998923, 6256.0, 6356.936430635635, 6396.648184349905, 6408.839779005562, 6417.903731443938, 6427.58220715652, 5972.8805423892145, 6081.5134789217645, 6256.249250090018, 6258.280297765815, 6262.997920332907], "unit": "score", "name": "prototype.html", "value": 4743.1052571255}, {"lowerIsBetter": false, "replicates": [716.7742161219219, 732.4653003307582, 740.300416106779, 758.9468737188396, 852.0, 14617.342219600117, 14693.33879975401, 14757.704845903088, 14777.48278810242, 14844.554663360117, 13068.0, 13141.54004609839, 13154.276514791683, 13160.276184809856, 13183.143095698773, 645.1484041065795, 791.996040019802, 814.975550733476, 823.1069289820551, 823.2919689067397, 810.9959450202741, 814.2142832166958, 819.1194465949098, 820.3109388113983, 824.3858325547476, 685.2975699907585, 857.2070834478114, 857.3184318466803, 861.9741407757746, 861.9827603447959, 841.7474757572734, 850.3877208409934, 856.4047986649281, 856.7772379181396, 857.2970164465141, 621.5897507644978, 621.9751209951596, 622.0948519903575, 622.2532960447481, 622.7664625765339, 14093.224872632001, 14170.07894486855, 14170.504032358922, 14171.149731016068, 14189.148651080968, 12560.623181304576, 12825.16636418639, 12915.547955821501, 13339.466421343135, 13441.32793360338, 10931.289466184673, 11001.339919604769, 11098.500567474402, 11193.49629266685, 11281.49233284496, 3743.1765011697385, 3775.5846856846, 3780.924381512382, 3836.1943991761764, 3883.631055049794, 52777.2083418749, 53774.19338709922, 57334.71332643352, 58929.7053514734, 59093.0, 10143.18854491639, 10639.574417023232, 10794.622188223375, 10930.890691093146, 11062.502187401586, 19268.614627707648, 19375.51561210981, 19393.806061939482, 19450.319238826574, 19475.8052419474, 7915.456695506419, 7924.286814186751, 7945.920540794518, 7971.043474782947, 8085.393595480363, 4255.8084886180195, 4271.957280427156, 4327.653787696977, 4330.328799036154, 4396.120775844844, 3380.4929260611107, 3411.5906091269208, 3415.334009868052, 3419.3161367726057, 3471.4272145096284, 565.4591238874035, 581.5115303145378, 581.8516278349078, 591.3583761618606, 594.7442599682091, 533.6717918480107, 600.2856600645218, 668.2281964331205, 726.5059759363578, 726.8001299642641, 7819.218078192135, 8007.159248278964, 8237.917620823835, 8293.295069919004, 8316.334693224528, 672.6502218846173, 690.8790961581703, 695.7495301691387, 708.4580296073508, 721.2895298131336, 3788.6021967693546, 3854.3811599128435, 3965.861194858224, 3981.8606348777653, 4018.9598104018587, 68400.0, 68849.0, 69012.0, 69141.0, 69275.3072469279, 58950.0, 62113.68943155255, 62881.0, 63016.05475917865, 63328.0, 55406.72296638491, 55546.44453555493, 55829.0, 56601.71699141478, 57489.712551436976, 7744.419168562267, 8039.995000624922, 8123.7156699515235, 8318.584070796314, 8357.122502137432, 39880.60119398769, 40198.39702404525, 40955.38566921558, 41331.0, 41359.586404136775, 49250.0, 51576.48423515717, 53516.46483535115, 53755.19367209573, 54033.18950215828, 11699.824502632297, 11753.823692644446, 12191.268523888595, 12309.322987235788, 12552.623421297376, 10043.849342260019, 11685.883141168819, 12033.217840840318, 12106.636800895987, 12674.62547512492, 11522.769544608893, 11609.883901161218, 11638.88361116412, 11689.473973671034, 11763.117766167401, 11730.413479326171, 11869.76260474803, 11994.460249288628, 12035.398230088636, 12264.570740024057, 11719.414029298672, 11896.107791915814, 11925.344106073902, 11927.880721192678, 11934.641960741192, 10223.437710925971, 10309.639162629272, 10382.584696612052, 10412.114970227616, 10600.734981625521, 9992.250581206294, 10271.383716977005, 10286.897131028594, 10302.639407620996, 10320.174386049248], "unit": "score", "name": "yui.html", "value": 6637.398248677851}], "name": "dromaeo_css", "value": 7068.163173113516}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 106.0, 110.0, 108.0, 112.0, 98.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 152.0, 166.0, 132.0, 156.0, 155.0, 127.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 159.0, 160.0, 159.0, 161.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 95.0, 99.0, 74.0, 72.0, 72.0, 116.0, 104.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 146.0, 93.0, 94.0, 94.0, 148.0, 93.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 54.0, 55.0, 53.0, 54.0, 56.0, 62.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 65.0, 60.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.8}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 77.0, 79.0, 79.0, 78.0, 79.0, 77.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 111.0, 107.0, 115.0, 113.0, 122.0, 111.0, 107.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.3}, {"lowerIsBetter": true, "replicates": [141.0, 134.0, 140.0, 141.0, 139.0, 132.0, 140.0, 141.0, 138.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 65.0, 65.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.8}], "name": "kraken", "value": 1478.3}]} 08:51:48 INFO - Return code: 0 08:51:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:51:48 ERROR - # TBPL SUCCESS # 08:51:48 INFO - Running post-action listener: _resource_record_post_action 08:51:48 INFO - Running post-run listener: _resource_record_post_run 08:51:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 20480; Write bytes: 539590656; Read time: 64; Write time: 499308 08:51:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242798592; Read time: 0; Write time: 273240 08:51:49 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 20480; Write bytes: 296792064; Read time: 64; Write time: 226068 08:51:49 INFO - Running post-run listener: _upload_blobber_files 08:51:49 INFO - Blob upload gear active. 08:51:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:51:49 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:51:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:51:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:50 INFO - (blobuploader) - INFO - Done attempting. 08:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:51 INFO - (blobuploader) - INFO - Done attempting. 08:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:51 INFO - Return code: 0 08:51:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08181847b5a58a5cc3c8316988453a79cc471208fe484b4da01ae53bc2f16597fd430087df1a1c837e2375e6bffce62994d41032c5fcf1768af9fc30bc58581a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbe3ef119077db0d30b9c7d0535124ebe5ac1c7426f4acfa0682d5fc951f39318dc11392d5fae6b9dab96c8f56bc5f14d83fbddcc7faf44c39071d2b4ca0f7b6"} 08:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:51:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:51:51 INFO - Contents: 08:51:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08181847b5a58a5cc3c8316988453a79cc471208fe484b4da01ae53bc2f16597fd430087df1a1c837e2375e6bffce62994d41032c5fcf1768af9fc30bc58581a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbe3ef119077db0d30b9c7d0535124ebe5ac1c7426f4acfa0682d5fc951f39318dc11392d5fae6b9dab96c8f56bc5f14d83fbddcc7faf44c39071d2b4ca0f7b6"} 08:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:51 INFO - Copying logs to upload dir... 08:51:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.461337 ========= master_lag: 3.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-24 08:51:54.893188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 08:51:54.897060) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 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/08181847b5a58a5cc3c8316988453a79cc471208fe484b4da01ae53bc2f16597fd430087df1a1c837e2375e6bffce62994d41032c5fcf1768af9fc30bc58581a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbe3ef119077db0d30b9c7d0535124ebe5ac1c7426f4acfa0682d5fc951f39318dc11392d5fae6b9dab96c8f56bc5f14d83fbddcc7faf44c39071d2b4ca0f7b6"} build_url:https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/VQNL3q48QjefBTQe8h7Ytg/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/08181847b5a58a5cc3c8316988453a79cc471208fe484b4da01ae53bc2f16597fd430087df1a1c837e2375e6bffce62994d41032c5fcf1768af9fc30bc58581a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbe3ef119077db0d30b9c7d0535124ebe5ac1c7426f4acfa0682d5fc951f39318dc11392d5fae6b9dab96c8f56bc5f14d83fbddcc7faf44c39071d2b4ca0f7b6"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 08:51:55.027020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:51:55.027357) ========= 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=00204705a9daa57ed339a427000001b9-1458832754.812795-299185808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:51:55.043287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 08:51:55.043576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 08:51:55.043860) ========= ========= Total master_lag: 3.92 =========