builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1458238731.2 results: success (0) buildid: 20160317083642 builduid: e58bd1183bc84ab2af913d8ac7f16fca revision: 5c5cf183a60890e651380e00533ce10d60375ffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.201813) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.202248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.202535) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006276 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.224722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.225019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.237950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.238206) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.286324) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.286586) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.286909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.287194) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 11:18:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-03-17 11:18:52 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.478427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.478735) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.527724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:51.528065) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c5cf183a60890e651380e00533ce10d60375ffb --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 5c5cf183a60890e651380e00533ce10d60375ffb --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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 11:18:52,313 truncating revision to first 12 chars 2016-03-17 11:18:52,313 Setting DEBUG logging. 2016-03-17 11:18:52,313 attempt 1/10 2016-03-17 11:18:52,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c5cf183a608?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 11:18:52,562 unpacking tar archive at: fx-team-5c5cf183a608/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523032 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:52.102429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:52.102761) ========= echo 5c5cf183a60890e651380e00533ce10d60375ffb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5c5cf183a60890e651380e00533ce10d60375ffb'] 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5c5cf183a60890e651380e00533ce10d60375ffb program finished with exit code 0 elapsedTime=0.004353 script_repo_revision: '5c5cf183a60890e651380e00533ce10d60375ffb' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:52.151228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:52.151503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 11:18:52.161050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-17 11:18:52.161318) ========= /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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:53 INFO - MultiFileLogger online at 20160317 11:18:53 in /builds/slave/test-pgo 11:18:53 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 11:18:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:18:53 INFO - {'append_to_log': False, 11:18:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:18:53 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:18:53 INFO - 'branch': 'Fx-Team', 11:18:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:53 INFO - 'config_files': ('talos/linux_config.py',), 11:18:53 INFO - 'default_actions': ('clobber', 11:18:53 INFO - 'read-buildbot-config', 11:18:53 INFO - 'download-and-extract', 11:18:53 INFO - 'populate-webroot', 11:18:53 INFO - 'create-virtualenv', 11:18:53 INFO - 'install', 11:18:53 INFO - 'run-tests'), 11:18:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:53 INFO - 'download_minidump_stackwalk': True, 11:18:53 INFO - 'download_symbols': 'ondemand', 11:18:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:53 INFO - 'installer_path': 'installer.exe', 11:18:53 INFO - 'log_level': 'info', 11:18:53 INFO - 'log_name': 'talos', 11:18:53 INFO - 'log_to_console': True, 11:18:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:53 INFO - 'opt_config_files': (), 11:18:53 INFO - 'pip_index': False, 11:18:53 INFO - 'sps_profile': False, 11:18:53 INFO - 'sps_profile_interval': 0, 11:18:53 INFO - 'suite': 'dromaeojs', 11:18:53 INFO - 'system_bits': '32', 11:18:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:53 INFO - 'title': 'talos-linux64-ix-002', 11:18:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:53 INFO - 'use_talos_json': True, 11:18:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:18:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:53 INFO - 'work_dir': 'build'} 11:18:53 INFO - ##### 11:18:53 INFO - ##### Running clobber step. 11:18:53 INFO - ##### 11:18:53 INFO - Running pre-action listener: _resource_record_pre_action 11:18:53 INFO - Running main action method: clobber 11:18:53 INFO - rmtree: /builds/slave/test-pgo/build 11:18:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:18:53 INFO - Running post-action listener: _resource_record_post_action 11:18:53 INFO - ##### 11:18:53 INFO - ##### Running read-buildbot-config step. 11:18:53 INFO - ##### 11:18:53 INFO - Running pre-action listener: _resource_record_pre_action 11:18:53 INFO - Running main action method: read_buildbot_config 11:18:53 INFO - Using buildbot properties: 11:18:53 INFO - { 11:18:53 INFO - "project": "", 11:18:53 INFO - "product": "firefox", 11:18:53 INFO - "script_repo_revision": "production", 11:18:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:18:53 INFO - "repository": "", 11:18:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:18:53 INFO - "buildid": "20160317083642", 11:18:53 INFO - "pgo_build": "True", 11:18:53 INFO - "basedir": "/builds/slave/test-pgo", 11:18:53 INFO - "buildnumber": 546, 11:18:53 INFO - "slavename": "talos-linux64-ix-002", 11:18:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:18:53 INFO - "platform": "ubuntu64_hw", 11:18:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:53 INFO - "branch": "fx-team", 11:18:53 INFO - "repo_path": "integration/fx-team", 11:18:53 INFO - "revision": "5c5cf183a60890e651380e00533ce10d60375ffb", 11:18:53 INFO - "stage_platform": "linux64-pgo", 11:18:53 INFO - "builduid": "e58bd1183bc84ab2af913d8ac7f16fca", 11:18:53 INFO - "slavebuilddir": "test" 11:18:53 INFO - } 11:18:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:18:53 INFO - Running post-action listener: _resource_record_post_action 11:18:53 INFO - ##### 11:18:53 INFO - ##### Running download-and-extract step. 11:18:53 INFO - ##### 11:18:53 INFO - Running pre-action listener: _resource_record_pre_action 11:18:53 INFO - Running main action method: download_and_extract 11:18:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:53 INFO - https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:54 INFO - Downloaded 1361 bytes. 11:18:54 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:18:54 INFO - Using the following test package requirements: 11:18:54 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'jsshell-linux-x86_64.zip'], 11:18:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:54 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18: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')]} 11:18:54 INFO - https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:56 INFO - Downloaded 23578797 bytes. 11:18:56 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'] 11:18:56 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 11:18:57 INFO - Return code: 0 11:18:57 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 11:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:57 INFO - https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:18:58 INFO - Downloaded 23578797 bytes. 11:18:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:18:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:19:00 INFO - Return code: 0 11:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:00 INFO - https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:19:01 INFO - Downloaded 10846565 bytes. 11:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:19:01 INFO - Return code: 0 11:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:01 INFO - https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:19:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:19:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:19:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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 11:19:02 INFO - Downloaded 57656726 bytes. 11:19:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:19:02 INFO - mkdir: /builds/slave/test-pgo/properties 11:19:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:19:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:19:02 INFO - Contents: 11:19:02 INFO - build_url:https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:19:03 INFO - Running post-action listener: _resource_record_post_action 11:19:03 INFO - Running post-action listener: set_extra_try_arguments 11:19:03 INFO - ##### 11:19:03 INFO - ##### Running populate-webroot step. 11:19:03 INFO - ##### 11:19:03 INFO - Running pre-action listener: _resource_record_pre_action 11:19:03 INFO - Running main action method: populate_webroot 11:19:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:19:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:19:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:19:03 INFO - '--tppagecycles', 11:19:03 INFO - '7'], 11:19:03 INFO - 'tests': ['tsvgm']}}, 11:19:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:19:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:19:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:19:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:19:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'tests': ['damp', 'tps']}, 11:19:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['damp', 'tps']}, 11:19:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:19:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:19:03 INFO - 'other': {'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'other_l64': {'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'other_nol64': {'tests': ['a11yr', 11:19:03 INFO - 'ts_paint', 11:19:03 INFO - 'tpaint', 11:19:03 INFO - 'sessionrestore', 11:19:03 INFO - 'sessionrestore_no_auto_restore', 11:19:03 INFO - 'tabpaint']}, 11:19:03 INFO - 'svgr': {'tests': ['tsvgx', 11:19:03 INFO - 'tsvgr_opacity', 11:19:03 INFO - 'tart', 11:19:03 INFO - 'tscrollx', 11:19:03 INFO - 'cart']}, 11:19:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['tsvgx', 11:19:03 INFO - 'tsvgr_opacity', 11:19:03 INFO - 'tart', 11:19:03 INFO - 'tscrollx', 11:19:03 INFO - 'cart']}, 11:19:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'tests': ['tp5o']}, 11:19:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'talos_options': ['--e10s'], 11:19:03 INFO - 'tests': ['tp5o']}, 11:19:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'talos_options': ['--xperf_path', 11:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:03 INFO - 'tests': ['tp5n']}, 11:19:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:03 INFO - 'talos_options': ['--e10s', 11:19:03 INFO - '--xperf_path', 11:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:03 INFO - 'tests': ['tp5n']}}, 11:19:03 INFO - 'talos.zip': {'path': '', 11:19:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:19:03 INFO - Running post-action listener: _resource_record_post_action 11:19:03 INFO - ##### 11:19:03 INFO - ##### Running create-virtualenv step. 11:19:03 INFO - ##### 11:19:03 INFO - Running pre-action listener: _resource_record_pre_action 11:19:03 INFO - Running main action method: create_virtualenv 11:19:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:19:03 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 11:19:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:19:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:19:03 INFO - Using real prefix '/usr' 11:19:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:19:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:06 INFO - Installing pip.................done. 11:19:06 INFO - Return code: 0 11:19:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:19:06 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')]} 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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')]} 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:06 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 11:19:06 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 11:19:06 INFO - Using env: {'DISPLAY': ':0', 11:19:06 INFO - 'HOME': '/home/cltbld', 11:19:06 INFO - 'LANG': 'en_US.UTF-8', 11:19:06 INFO - 'LANGUAGE': 'en_US:en', 11:19:06 INFO - 'LOGNAME': 'cltbld', 11:19:06 INFO - 'MAIL': '/var/mail/cltbld', 11:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:06 INFO - 'MOZ_NO_REMOTE': '1', 11:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:06 INFO - 'NO_EM_RESTART': '1', 11:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:06 INFO - 'SHELL': '/bin/bash', 11:19:06 INFO - 'SHLVL': '1', 11:19:06 INFO - 'TERM': 'linux', 11:19:06 INFO - 'TMOUT': '86400', 11:19:06 INFO - 'USER': 'cltbld', 11:19:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:06 INFO - '_': '/tools/buildbot/bin/python'} 11:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:06 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 11:19:06 INFO - Cleaning up... 11:19:06 INFO - Return code: 0 11:19:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:19:06 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')]} 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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')]} 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:06 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 11:19:06 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 11:19:06 INFO - Using env: {'DISPLAY': ':0', 11:19:06 INFO - 'HOME': '/home/cltbld', 11:19:06 INFO - 'LANG': 'en_US.UTF-8', 11:19:06 INFO - 'LANGUAGE': 'en_US:en', 11:19:06 INFO - 'LOGNAME': 'cltbld', 11:19:06 INFO - 'MAIL': '/var/mail/cltbld', 11:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:06 INFO - 'MOZ_NO_REMOTE': '1', 11:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:06 INFO - 'NO_EM_RESTART': '1', 11:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:06 INFO - 'SHELL': '/bin/bash', 11:19:06 INFO - 'SHLVL': '1', 11:19:06 INFO - 'TERM': 'linux', 11:19:06 INFO - 'TMOUT': '86400', 11:19:06 INFO - 'USER': 'cltbld', 11:19:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:06 INFO - '_': '/tools/buildbot/bin/python'} 11:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:06 INFO - Downloading/unpacking psutil>=0.7.1 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:08 INFO - Installing collected packages: psutil 11:19:08 INFO - Running setup.py install for psutil 11:19:08 INFO - building 'psutil._psutil_linux' extension 11:19:08 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 11:19:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:19:09 INFO - building 'psutil._psutil_posix' extension 11:19:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:19:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:09 INFO - Successfully installed psutil 11:19:09 INFO - Cleaning up... 11:19:09 INFO - Return code: 0 11:19:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:19:09 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')]} 11:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:09 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')]} 11:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:09 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:09 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 11:19:09 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 11:19:09 INFO - Using env: {'DISPLAY': ':0', 11:19:09 INFO - 'HOME': '/home/cltbld', 11:19:09 INFO - 'LANG': 'en_US.UTF-8', 11:19:09 INFO - 'LANGUAGE': 'en_US:en', 11:19:09 INFO - 'LOGNAME': 'cltbld', 11:19:09 INFO - 'MAIL': '/var/mail/cltbld', 11:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:09 INFO - 'MOZ_NO_REMOTE': '1', 11:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:09 INFO - 'NO_EM_RESTART': '1', 11:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:09 INFO - 'SHELL': '/bin/bash', 11:19:09 INFO - 'SHLVL': '1', 11:19:09 INFO - 'TERM': 'linux', 11:19:09 INFO - 'TMOUT': '86400', 11:19:09 INFO - 'USER': 'cltbld', 11:19:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:09 INFO - '_': '/tools/buildbot/bin/python'} 11:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:19:09 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 11:19:09 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 11:19:09 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 11:19:09 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 11:19:09 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 11:19:09 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 11:19:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:19:11 INFO - Installing collected packages: mozsystemmonitor 11:19:11 INFO - Running setup.py install for mozsystemmonitor 11:19:11 INFO - Successfully installed mozsystemmonitor 11:19:11 INFO - Cleaning up... 11:19:11 INFO - Return code: 0 11:19:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:11 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:11 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 11:19:11 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 11:19:11 INFO - Using env: {'DISPLAY': ':0', 11:19:11 INFO - 'HOME': '/home/cltbld', 11:19:11 INFO - 'LANG': 'en_US.UTF-8', 11:19:11 INFO - 'LANGUAGE': 'en_US:en', 11:19:11 INFO - 'LOGNAME': 'cltbld', 11:19:11 INFO - 'MAIL': '/var/mail/cltbld', 11:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:11 INFO - 'MOZ_NO_REMOTE': '1', 11:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:11 INFO - 'NO_EM_RESTART': '1', 11:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:11 INFO - 'SHELL': '/bin/bash', 11:19:11 INFO - 'SHLVL': '1', 11:19:11 INFO - 'TERM': 'linux', 11:19:11 INFO - 'TMOUT': '86400', 11:19:11 INFO - 'USER': 'cltbld', 11:19:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:11 INFO - '_': '/tools/buildbot/bin/python'} 11:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:13 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 11:19:13 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 11:19:13 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 11:19:13 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 11:19:13 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 11:19:13 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 11:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:19:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:14 INFO - Downloading docopt-0.6.1.tar.gz 11:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:14 INFO - Running setup.py install for blobuploader 11:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:19:14 INFO - Running setup.py install for requests 11:19:15 INFO - Running setup.py install for docopt 11:19:15 INFO - Successfully installed blobuploader requests docopt 11:19:15 INFO - Cleaning up... 11:19:15 INFO - Return code: 0 11:19:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:15 INFO - Using env: {'DISPLAY': ':0', 11:19:15 INFO - 'HOME': '/home/cltbld', 11:19:15 INFO - 'LANG': 'en_US.UTF-8', 11:19:15 INFO - 'LANGUAGE': 'en_US:en', 11:19:15 INFO - 'LOGNAME': 'cltbld', 11:19:15 INFO - 'MAIL': '/var/mail/cltbld', 11:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:15 INFO - 'MOZ_NO_REMOTE': '1', 11:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:15 INFO - 'NO_EM_RESTART': '1', 11:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:15 INFO - 'SHELL': '/bin/bash', 11:19:15 INFO - 'SHLVL': '1', 11:19:15 INFO - 'TERM': 'linux', 11:19:15 INFO - 'TMOUT': '86400', 11:19:15 INFO - 'USER': 'cltbld', 11:19:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:15 INFO - '_': '/tools/buildbot/bin/python'} 11:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:19:15 INFO - Running setup.py (path:/tmp/pip-J_EUFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:19:15 INFO - Running setup.py (path:/tmp/pip-AZrK33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:19:15 INFO - Running setup.py (path:/tmp/pip-aHoYO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:19:15 INFO - Running setup.py (path:/tmp/pip-3LOdaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:19:15 INFO - Running setup.py (path:/tmp/pip-2gb9Ak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:19:15 INFO - Running setup.py (path:/tmp/pip-v25wSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:19:15 INFO - Running setup.py (path:/tmp/pip-9mnWge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:19:15 INFO - Running setup.py (path:/tmp/pip-nnqDHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:19:16 INFO - Running setup.py (path:/tmp/pip-Bg75Qd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:19:16 INFO - Running setup.py (path:/tmp/pip-U2GJh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:19:16 INFO - Running setup.py (path:/tmp/pip-HTvHsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:19:16 INFO - Running setup.py (path:/tmp/pip-dajvZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:19:16 INFO - Running setup.py (path:/tmp/pip-9atonP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:19:16 INFO - Running setup.py (path:/tmp/pip-dcMadg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:19:16 INFO - Running setup.py (path:/tmp/pip-l9T26N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:19:16 INFO - Running setup.py (path:/tmp/pip-Gpn_f7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:19:16 INFO - Running setup.py (path:/tmp/pip-RtsfI7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:16 INFO - Running setup.py install for manifestparser 11:19:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:19:16 INFO - Running setup.py install for mozcrash 11:19:16 INFO - Running setup.py install for mozdebug 11:19:16 INFO - Running setup.py install for mozdevice 11:19:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for mozfile 11:19:17 INFO - Running setup.py install for mozhttpd 11:19:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for mozinfo 11:19:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for mozInstall 11:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for mozleak 11:19:17 INFO - Running setup.py install for mozlog 11:19:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for moznetwork 11:19:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:19:17 INFO - Running setup.py install for mozprocess 11:19:17 INFO - Running setup.py install for mozprofile 11:19:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:19:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:19:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:19:18 INFO - Running setup.py install for mozrunner 11:19:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:19:18 INFO - Running setup.py install for mozscreenshot 11:19:18 INFO - Running setup.py install for moztest 11:19:18 INFO - Running setup.py install for mozversion 11:19:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:18 INFO - Cleaning up... 11:19:18 INFO - Return code: 0 11:19:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:19:18 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')]} 11:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:18 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')]} 11:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:18 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:18 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 11:19:18 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 11:19:18 INFO - Using env: {'DISPLAY': ':0', 11:19:18 INFO - 'HOME': '/home/cltbld', 11:19:18 INFO - 'LANG': 'en_US.UTF-8', 11:19:18 INFO - 'LANGUAGE': 'en_US:en', 11:19:18 INFO - 'LOGNAME': 'cltbld', 11:19:18 INFO - 'MAIL': '/var/mail/cltbld', 11:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:18 INFO - 'MOZ_NO_REMOTE': '1', 11:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:18 INFO - 'NO_EM_RESTART': '1', 11:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:18 INFO - 'SHELL': '/bin/bash', 11:19:18 INFO - 'SHLVL': '1', 11:19:18 INFO - 'TERM': 'linux', 11:19:18 INFO - 'TMOUT': '86400', 11:19:18 INFO - 'USER': 'cltbld', 11:19:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:18 INFO - '_': '/tools/buildbot/bin/python'} 11:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:19:18 INFO - Running setup.py (path:/tmp/pip-ZTTlCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:19:18 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)) 11:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:19:18 INFO - Running setup.py (path:/tmp/pip-pZb3oK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:19:18 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)) 11:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:19:18 INFO - Running setup.py (path:/tmp/pip-6yhXEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:19:18 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)) 11:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:19:18 INFO - Running setup.py (path:/tmp/pip-ollVPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:19:18 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)) 11:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:19:18 INFO - Running setup.py (path:/tmp/pip-3fze0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:19:19 INFO - Running setup.py (path:/tmp/pip-FUcPCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:19:19 INFO - Running setup.py (path:/tmp/pip-T1FwEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:19:19 INFO - Running setup.py (path:/tmp/pip-0mFLlG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:19:19 INFO - Running setup.py (path:/tmp/pip-TAkquz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:19:19 INFO - Running setup.py (path:/tmp/pip-D_ujem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:19:19 INFO - Running setup.py (path:/tmp/pip-OvnwTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:19:19 INFO - Running setup.py (path:/tmp/pip-uQHFaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:19:19 INFO - Running setup.py (path:/tmp/pip-5vFYg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:19:19 INFO - Running setup.py (path:/tmp/pip-maiFML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:19:19 INFO - Running setup.py (path:/tmp/pip-BChqZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:19:19 INFO - Running setup.py (path:/tmp/pip-wrj_3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:19:19 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)) 11:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:19:19 INFO - Running setup.py (path:/tmp/pip-g8B84r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:19:19 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)) 11:19:19 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)) 11:19:19 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)) 11:19:19 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)) 11:19:19 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)) 11:19:19 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)) 11:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:21 INFO - Downloading blessings-1.6.tar.gz 11:19:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:21 INFO - Installing collected packages: blessings 11:19:21 INFO - Running setup.py install for blessings 11:19:21 INFO - Successfully installed blessings 11:19:21 INFO - Cleaning up... 11:19:21 INFO - Return code: 0 11:19:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:19:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:19:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:19:22 INFO - Reading from file tmpfile_stdout 11:19:22 INFO - Current package versions: 11:19:22 INFO - argparse == 1.2.1 11:19:22 INFO - blessings == 1.6 11:19:22 INFO - blobuploader == 1.2.4 11:19:22 INFO - docopt == 0.6.1 11:19:22 INFO - manifestparser == 1.1 11:19:22 INFO - mozInstall == 1.12 11:19:22 INFO - mozcrash == 0.17 11:19:22 INFO - mozdebug == 0.1 11:19:22 INFO - mozdevice == 0.48 11:19:22 INFO - mozfile == 1.2 11:19:22 INFO - mozhttpd == 0.7 11:19:22 INFO - mozinfo == 0.9 11:19:22 INFO - mozleak == 0.1 11:19:22 INFO - mozlog == 3.1 11:19:22 INFO - moznetwork == 0.27 11:19:22 INFO - mozprocess == 0.22 11:19:22 INFO - mozprofile == 0.28 11:19:22 INFO - mozrunner == 6.11 11:19:22 INFO - mozscreenshot == 0.1 11:19:22 INFO - mozsystemmonitor == 0.0 11:19:22 INFO - moztest == 0.7 11:19:22 INFO - mozversion == 1.4 11:19:22 INFO - psutil == 3.1.1 11:19:22 INFO - requests == 1.2.3 11:19:22 INFO - wsgiref == 0.1.2 11:19:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:19: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')]} 11:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:22 INFO - Using env: {'DISPLAY': ':0', 11:19:22 INFO - 'HOME': '/home/cltbld', 11:19:22 INFO - 'LANG': 'en_US.UTF-8', 11:19:22 INFO - 'LANGUAGE': 'en_US:en', 11:19:22 INFO - 'LOGNAME': 'cltbld', 11:19:22 INFO - 'MAIL': '/var/mail/cltbld', 11:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:22 INFO - 'MOZ_NO_REMOTE': '1', 11:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:22 INFO - 'NO_EM_RESTART': '1', 11:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:22 INFO - 'SHELL': '/bin/bash', 11:19:22 INFO - 'SHLVL': '1', 11:19:22 INFO - 'TERM': 'linux', 11:19:22 INFO - 'TMOUT': '86400', 11:19:22 INFO - 'USER': 'cltbld', 11:19:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:22 INFO - '_': '/tools/buildbot/bin/python'} 11:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 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)) 11:19:22 INFO - Cleaning up... 11:19:22 INFO - Return code: 0 11:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:19: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')]} 11:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:19:22 INFO - Using env: {'DISPLAY': ':0', 11:19:22 INFO - 'HOME': '/home/cltbld', 11:19:22 INFO - 'LANG': 'en_US.UTF-8', 11:19:22 INFO - 'LANGUAGE': 'en_US:en', 11:19:22 INFO - 'LOGNAME': 'cltbld', 11:19:22 INFO - 'MAIL': '/var/mail/cltbld', 11:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:22 INFO - 'MOZ_NO_REMOTE': '1', 11:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:22 INFO - 'NO_EM_RESTART': '1', 11:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:22 INFO - 'SHELL': '/bin/bash', 11:19:22 INFO - 'SHLVL': '1', 11:19:22 INFO - 'TERM': 'linux', 11:19:22 INFO - 'TMOUT': '86400', 11:19:22 INFO - 'USER': 'cltbld', 11:19:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:22 INFO - '_': '/tools/buildbot/bin/python'} 11:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:22 INFO - Downloading/unpacking jsonschema 11:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:24 INFO - Downloading/unpacking functools32 (from jsonschema) 11:19:24 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 11:19:24 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 11:19:24 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 11:19:24 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 11:19:24 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 11:19:24 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 11:19:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:24 INFO - warning: no files found matching '*.txt' 11:19:24 INFO - no previously-included directories found matching 'build' 11:19:24 INFO - no previously-included directories found matching 'dist' 11:19:24 INFO - no previously-included directories found matching '.git*' 11:19:24 INFO - Installing collected packages: jsonschema, functools32 11:19:24 INFO - Running setup.py install for functools32 11:19:24 INFO - warning: no files found matching '*.txt' 11:19:24 INFO - no previously-included directories found matching 'build' 11:19:24 INFO - no previously-included directories found matching 'dist' 11:19:24 INFO - no previously-included directories found matching '.git*' 11:19:24 INFO - Successfully installed jsonschema functools32 11:19:24 INFO - Cleaning up... 11:19:24 INFO - Return code: 0 11:19:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:19:24 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')]} 11:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:24 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')]} 11:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:24 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 0x7f1f3be5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', '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 11:19:24 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 11:19:24 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 11:19:24 INFO - Using env: {'DISPLAY': ':0', 11:19:24 INFO - 'HOME': '/home/cltbld', 11:19:24 INFO - 'LANG': 'en_US.UTF-8', 11:19:24 INFO - 'LANGUAGE': 'en_US:en', 11:19:24 INFO - 'LOGNAME': 'cltbld', 11:19:24 INFO - 'MAIL': '/var/mail/cltbld', 11:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:24 INFO - 'MOZ_NO_REMOTE': '1', 11:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:24 INFO - 'NO_EM_RESTART': '1', 11:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:24 INFO - 'SHELL': '/bin/bash', 11:19:24 INFO - 'SHLVL': '1', 11:19:24 INFO - 'TERM': 'linux', 11:19:24 INFO - 'TMOUT': '86400', 11:19:24 INFO - 'USER': 'cltbld', 11:19:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:24 INFO - '_': '/tools/buildbot/bin/python'} 11:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:25 INFO - Downloading/unpacking flake8 11:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:19:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:19:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:27 INFO - no previously-included directories found matching 'docs/_build' 11:19:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:19:27 INFO - Running setup.py install for pep8 11:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:27 INFO - no previously-included directories found matching 'docs/_build' 11:19:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:19:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:19:27 INFO - Cleaning up... 11:19:27 INFO - Return code: 0 11:19:27 INFO - Running post-action listener: _resource_record_post_action 11:19:27 INFO - Running post-action listener: _start_resource_monitoring 11:19:27 INFO - Starting resource monitoring. 11:19:27 INFO - ##### 11:19:27 INFO - ##### Running install step. 11:19:27 INFO - ##### 11:19:27 INFO - Running pre-action listener: _resource_record_pre_action 11:19:27 INFO - Running main action method: install 11:19:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:19:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:19:28 INFO - Reading from file tmpfile_stdout 11:19:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:19:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:19:28 INFO - Reading from file tmpfile_stdout 11:19:28 INFO - Output received: 11:19:28 INFO - Usage: mozinstall [options] installer 11:19:28 INFO - Options: 11:19:28 INFO - -h, --help show this help message and exit 11:19:28 INFO - -d DEST, --destination=DEST 11:19:28 INFO - Directory to install application into. [default: 11:19:28 INFO - "/builds/slave/test-pgo"] 11:19:28 INFO - --app=APP Application being installed. [default: firefox] 11:19:28 INFO - mkdir: /builds/slave/test-pgo/build/application 11:19:28 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'] 11:19:28 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 11:19:44 INFO - Reading from file tmpfile_stdout 11:19:44 INFO - Output received: 11:19:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:19:44 INFO - Running post-action listener: _resource_record_post_action 11:19:44 INFO - ##### 11:19:44 INFO - ##### Running run-tests step. 11:19:44 INFO - ##### 11:19:44 INFO - Running pre-action listener: _resource_record_pre_action 11:19:44 INFO - Running main action method: run_tests 11:19:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:19:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:19:44 INFO - Python 2.7.3 11:19:44 INFO - Return code: 0 11:19:44 INFO - grabbing minidump binary from tooltool 11:19:44 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')]} 11:19:44 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 0x21c71d0>, '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 0x21ca750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cabe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:19:44 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 11:19:44 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 11:19:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:44 INFO - Return code: 0 11:19:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:19:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:19:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:19:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:19:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:19:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:19:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:19:45 INFO - Return code: 0 11:19:45 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/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:19:45 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/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 11:19:45 INFO - Using env: {'DISPLAY': ':0', 11:19:45 INFO - 'HOME': '/home/cltbld', 11:19:45 INFO - 'LANG': 'en_US.UTF-8', 11:19:45 INFO - 'LANGUAGE': 'en_US:en', 11:19:45 INFO - 'LOGNAME': 'cltbld', 11:19:45 INFO - 'MAIL': '/var/mail/cltbld', 11:19:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:19:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:45 INFO - 'MOZ_NO_REMOTE': '1', 11:19:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:45 INFO - 'NO_EM_RESTART': '1', 11:19:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:19:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:19:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:19:45 INFO - 'SHELL': '/bin/bash', 11:19:45 INFO - 'SHLVL': '1', 11:19:45 INFO - 'TERM': 'linux', 11:19:45 INFO - 'TMOUT': '86400', 11:19:45 INFO - 'USER': 'cltbld', 11:19:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510', 11:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:45 INFO - '_': '/tools/buildbot/bin/python'} 11:19:45 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/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:19:45 INFO - mozversion application_buildid: 20160317083642 11:19:45 INFO - mozversion application_changeset: 5c5cf183a60890e651380e00533ce10d60375ffb 11:19:45 INFO - mozversion application_display_name: Nightly 11:19:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:45 INFO - mozversion application_name: Firefox 11:19:45 INFO - mozversion application_remotingname: firefox 11:19:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:45 INFO - mozversion application_vendor: Mozilla 11:19:45 INFO - mozversion application_version: 48.0a1 11:19:45 INFO - mozversion platform_buildid: 20160317083642 11:19:45 INFO - mozversion platform_changeset: 5c5cf183a60890e651380e00533ce10d60375ffb 11:19:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:45 INFO - mozversion platform_version: 48.0a1 11:19:45 INFO - using testdate: 1458238785 11:19:45 INFO - actual date: 1458238785 11:19:45 INFO - starting webserver on 'localhost:44889' 11:19:45 INFO - SUITE-START | Running 2 tests 11:19:45 INFO - TEST-START | dromaeo_css 11:19:45 INFO - operating with platform_type : linux_ 11:19:45 INFO - Initialising browser for dromaeo_css test... 11:19:45 INFO - TEST-INFO | started process 16311 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXzlZf/profile http://localhost:44889/getInfo.html) 11:19:50 INFO - PROCESS | 16311 | __metrics Screen width/height:1600/1200 11:19:50 INFO - PROCESS | 16311 | colorDepth:24 11:19:50 INFO - PROCESS | 16311 | Browser inner width/height: 1024/697 11:19:50 INFO - PROCESS | 16311 | __metrics 11:19:50 ERROR - PROCESS | 16311 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:19:51 INFO - TEST-INFO | 16311: exit 0 11:19:51 INFO - Browser initialized. 11:19:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:51 INFO - TEST-INFO | started process 16407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXzlZf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:03 INFO - PROCESS | 16407 | RSS: Main: 153505792 11:20:03 INFO - PROCESS | 16407 | 11:20:55 INFO - PROCESS | 16407 | 1458238855086 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] 11:23:01 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44889/tests/dromaeo/cssquery-ext.html) 11:23:02 INFO - PROCESS | 16407 | RSS: Main: 247250944 11:23:02 INFO - PROCESS | 16407 | 11:26:04 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-ext.html (next: http://localhost:44889/tests/dromaeo/cssquery-jquery.html) 11:26:05 INFO - PROCESS | 16407 | RSS: Main: 239955968 11:26:05 INFO - PROCESS | 16407 | 11:29:07 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44889/tests/dromaeo/cssquery-mootools.html) 11:29:07 INFO - PROCESS | 16407 | RSS: Main: 235409408 11:29:07 INFO - PROCESS | 16407 | 11:32:09 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44889/tests/dromaeo/cssquery-prototype.html) 11:32:10 INFO - PROCESS | 16407 | RSS: Main: 217239552 11:32:10 INFO - PROCESS | 16407 | 11:35:12 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44889/tests/dromaeo/cssquery-yui.html) 11:35:13 INFO - PROCESS | 16407 | RSS: Main: 218054656 11:35:13 INFO - PROCESS | 16407 | 11:38:15 INFO - PROCESS | 16407 | Cycle 1(1): loaded http://localhost:44889/tests/dromaeo/cssquery-yui.html (next: http://localhost:44889/tests/dromaeo/cssquery-dojo.html) 11:38:15 INFO - PROCESS | 16407 | RSS: Main: 271458304 11:38:15 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | __start_tp_report 11:38:16 INFO - PROCESS | 16407 | _x_x_mozilla_page_load 11:38:16 INFO - PROCESS | 16407 | _x_x_mozilla_page_load_details 11:38:16 INFO - PROCESS | 16407 | |i|pagename|runs| 11:38:16 INFO - PROCESS | 16407 | |0;dojo.html;3017.0496293667493;3054;3090.3664748726515;3090.8145511269327;3124.265797537579;5036.093503169428;5165.328507294052;5167.302414174081;5205.505476979691;5222.294990176325;5156.690598564089;5209.609279304048;5212.192110222922;5228.686278823273;5249.107651699211;4642.651801114913;4676.111538807632;4703.764811759398;4759.857204283877;4798.928016079762;4703.811847526094;4730.574248317651;4750.738709370983;4781.7370044647705;4818.68678535894;4600.42494688164;4611.608013318855;4676.672632915697;4691.953080469186;4707.458642256116;4644.442666879962;4656.720596764205;4667.953320466786;4681.040386720748;4699.060187962387;4551.089782043605;4653.488116307203;4662.510436404163;4662.790174442158;4697.248440249544;5034.345535080416;5100.336956195708;5105.361829771278;5106.285120083191;5127.5385215330425;5503.642263252916;5512.869861678347;5513.807016754395;5524.806631767909;5529.502344788948;5389.83830485086;5531.585131115183;5539.778408863641;5540.9168862467095;5544.279243698334;5099.5410413063;5123.590112791005;5128.589712822965;5143.151380022292;5170;5572.080606699849;5573.331200255995;5575.080111781511;5581.6930068845795;5585.413531579125;5307.203919412119;5369.19462080691;5382.811601593926;5389.9191512127345;5401.648892821954;5567.47109024642;5576.749046292926;5590.91613625796;5598.58010649203;5638.323401191883;5509.283793106951;5523.861903452445;5524.088525393265;5524.14375771756;5529.557635389159;5293.073712100367;5383.461653834585;5439.755211015435;5504.366997795225;5565.693886836182;4235.407043013981;4238.0888109056705;4241.512226093977;4279.33670281107;4280.250956082736;3790.5261842269715;3799.316123097869;3807.162424266657;3827.5215598050245;3837.884863454101;5164.690118592896;5198.324217851655;5235.345581802275;5293.470652934676;5295.602829787781;5514.503694667499;5518.172274158908;5539.362973258127;5540.944590554042;5543.168524721244;5228.346456692913;5243.344581927259;5249.317588713519;5256.08018596744;5298.629095963245;4667.369905062841;4726.787294571753;4810.542998415145;4813.638977076664;4814.879628009257;5745.770169193269;5759.107338362561;5762;5765.048766953406;5771.192033115283;5488.313960754906;5505.394406615189;5509.917351239815;5514.420985796594;5547.583931205257;5571.8885622288135;5783.363829978614;5817.476427121579;5827.59206855533;5874.823755287348;5449.564034877121;5457.181422786613;5458.590605704509;5463;5464;5405.378381486179;5534;5544.306961629796;5547.667139971453;5597.328320601554;5401.4868587484125;5451.754671039892;5452.591055670761;5489.725513724218;5502.862428439321;5327.440618735132;5344.091504444332;5345.492178243061;5361.142217245222;5365.38298095724;5202.375714914235;5247.763850626808;5285.762140703754;5308.867278318073;5362.410134885237;5393.919091213714;5406.891862162656;5407.459254074561;5438.23864658956;5454.127339625641;5289.444608316071;5291.074062039051;5292.179712144623;5299.5230429261555;5341.62608617393 11:38:16 INFO - PROCESS | 16407 | |1;ext.html;536.9892602147958;564.5088772767692;568.4060157135792;582.1878479521067;599.5503372470647;29695.40609187815;30146.698533014664;38672.22655546887;38731.61268387315;38811.22377552447;41843.372349414785;42122;42259.78870105645;42283.36574951378;42344.15311693764;7539.924600754004;8533.91466085339;8632.093630168836;8722.38943273971;8722.520261385622;10228.079472847443;10471.790564188712;10473.057424831764;10474.319169253975;10477.790444191112;10236.795264094713;10322.174226061934;10330;10336.896631033705;10372.844407333858;10210.540525676362;10229.897701023006;10294.073533382032;10298.53656585448;10315.123214526775;10075.496225188785;10255.128314093312;10258.179345652405;10260.179185665129;10265.846012309821;41000;41201;41295.587044129476;41298.38052429216;41327.793361033;3363.764536482447;3448.517207590939;3493.1616412061176;3530.6292839251764;3900.8049597520294;31838.20404489883;32380.190495237806;32465.350692986245;32528.349433011208;32699.836500817582;3932.7836968966694;4002.6597739192202;4013.9598604013877;4118.794060296973;4121.175764847013;329371;330245;330257;330990.3450482756;331275;46403.375881843975;46919.29621055619;46923.53076469192;46958.295625565646;57526;45544.3168352475;45583.54416455793;45676;45732.542674573495;45750.313745293846;13358.131721438076;13374.197548147142;13421.66445838862;13453;13486.190828550121;9657.758556036155;10557.841632375521;10669;10751.247412681194;10790.51442685081;15122.54632361031;15222.543323700307;15407.845921540866;15633.60915977087;15680;5792.333881603585;5856.8535786604825;5902.612885971793;5968.22413086296;5981.312149102821;1003.4731765822855;1073.0878753059837;1102.6030628973563;1110.1451882050776;1129.954801807935;28656.283592909927;28673.71326286752;29242.268943276587;29410.411791764043;29515.85242073776;1082.155918383662;1093.4969913839564;1095.3482677806692;1146.7305183281921;1240.342618412243;15118;15590.298436570154;15597.454089107054;15628.609284767972;15761.921190394203;427369;428373;428628;433269;433391;58076.70961645165;58614;58767.41232587705;58793.238777540275;58825.41174588285;1196.1985469735298;1305.7584346895856;1325.7613629546581;1400.586826886071;1476.8006319146778;29540.556891646214;30791.234003247733;33501.32997340088;33540;33873.32253354968;44949.77525112484;45021.54978450305;45485;46397.53602464067;46704.532954670016;280645;284741;286072;286305;286523;30123.246918827204;34410.827945861114;34611;34959.65040349564;35624.46563301501;42442.57557424386;42526.362104569074;42596.5740342605;42736.57263427326;42856;35016;35084;37519.62480375161;37931.051723707125;38244.61755382411;37493.69024474362;37948.24103517859;38348.6165138345;39043.852588107926;39264.214715704955;39892.2021559573;40225.19549608933;40258.597414025484;40813.183736324514;40966.79516602398;33842.15394615056;33847.492287616195;34857.47713784245;35089.64910350864;35269.64730352664;24967.87516062408;25256;25318.49363012766;25383.492330152923;25409.745902540737 11:38:16 INFO - PROCESS | 16407 | |2;jquery.html;357.20521838908434;361.37842910194456;368.71977297254085;373.23673088533945;375.17648760969684;16984.915075424637;17350.82649173508;18041.368552100677;18252.72620910684;18353.90823045883;17757.112144392795;18151.183196756145;18708.719369209473;18738.718919216222;18770.718439223423;5383.2194331821765;5521.751521181536;5546.251256080438;5558.360788509332;5559.277293951781;4030.879073627781;5511.22842802008;5889.970550147244;6102.298235702907;6124.448799608034;6014.097885317194;6048.879022419549;6069.514438844903;6087.878242435148;6089.3301736809135;5953.642781433106;5961.165436838846;6035.094735789645;6170.8765824683705;6179.907301390438;3700.2599480104086;5207.9479205207845;5379.488948549882;5387.057264978613;5445.53712934401;20319.288824891206;20327;20443.48891277715;21997.23009694669;22128.778712212992;2162.675598660198;2725.2914242296947;2996.146098361978;3009.20256132123;3083.2908431060982;9775.41347519144;9777.46223957682;9788.706338809847;9837.90162098377;9905.80188396228;1931.3433432632971;2015.2442833937273;2024.8785072895673;2055.876647401161;2078.4596005038647;71357.2864271361;72714;72855.63572182211;73521.26478735197;73921.28098659847;10950.452477376099;11083.556657733601;11100.833487497694;11103.666889993314;11292.661220163409;14355.066920650124;14417.495387661382;14503.782443263359;14530.782038269434;14557.927210364092;7385.667644955883;7506.28690274423;7556.395488360918;7589.8861517077285;7611.961940190264;6987.371136597731;7039;7115.501914865909;7170.641467926583;7177.677004534704;4663.696859704109;4717.386739723814;4737.531365276706;4806.543378379049;4808.543188397097;1704.2330951072067;1748.3006797280934;1767.098779622402;1805.5305620538754;1808.3851490493296;480.60590315940595;486.0667518364748;490.5045903637352;899.4243684042218;1075.8166017380818;10658.68023959267;11239;11565.421728913521;11620.418979051014;11654.592089276835;477.4056299906569;479.1255957876819;490.2376804069635;491.2116053733777;494.6240856948673;5951.404859514014;6064.696765161724;6140.5701600887505;6144.938550614436;6179.368479927286;520529;521382;533903;534302;540197;79124.20875791284;79788.20211797807;81088.59455702802;81263;81973.18026819774;512.7538781384956;513.2839688634334;516.1303204101101;516.431924882626;518.1916210711303;10856.945715271373;10938.398388088413;11034.613788517363;11183.71387290472;11227.045701115496;35773.82113089522;35906.82046589855;36247.275054498234;36577.26845463129;36639.816800915825;52000;52065.479345207576;52068.21897671614;52129.47870521246;52203;8067.314278286177;8119.106898241071;8134.186581341818;8276.875846862422;8282.544460054754;11557.884421156017;11725.765484690088;12068.698282543006;12191.878081219074;12577.87422125767;10573;10640;10813.67558973232;10848.457577120955;11244.044256237985;10650.520726567478;10764;10772.622958196738;10787.784244315228;10968.341899486057;10329.380237185793;10984.725381865517;11065.059469945145;11305;11387;7831.725889593837;8054.959725201571;8099.716509922125;8195.303399211134;8244.505329679998;9809.509524523888;11257.592800899887;11398.94300528492;11432.542698291974;11452.312861228353 11:38:16 INFO - PROCESS | 16407 | |3;mootools.html;1323.4110820684798;1463.282991334246;1463.656040830405;1632.640819019816;1793.5964408008192;7435.888461673072;7589.051368578927;7622.3139917407425;7628.50414723044;7629;7550.093988721347;7575.848483030336;7631.046119235096;7647.732329368473;7648.617569121549;1926.6820974539185;2203.636399994007;2251.5271792923504;2276.3626184668237;2276.4422716434497;2220.678001689754;2240.4286906838734;2240.574290884727;2243.6410174372104;2250.1112060736;2144.6997420361163;2146.7960543748395;2217.135317226283;2218.4121207879925;2221.533477969628;2246.0454306919496;2279.794818466338;2284.1434462076636;2290.48464095578;2291.541691661674;2236.6421372580307;2238.9216377426874;2266.8186545076355;2269.943251418711;2271.44349634339;7814.257645523666;7820.530768153929;7847.607619618996;7848.68605255789;7853.293203611703;4829.903401931977;4874.512548745132;4899.926501102486;4903.509649035103;4931.876703082416;3317.668233176687;3325.3016866458074;3379.645137260577;3441.8451169697423;3457.913552161191;1023.9402218703606;1049.942253176075;1072.6406653770996;2031.177373163871;2049.067674208232;10322.277440579162;10340.793184136275;10341.586336546528;10383;10388.688339349832;4170.562090980464;4238.660907127484;4264.936025959551;4289.292266775947;4294.613484786384;8162;8204.794880127925;8210.425270231026;8213.178682131738;8217;4835.637327200474;4868.221084626513;4886.511348865085;4897.926531102036;4910.288008238786;3850.7111966602615;4388.802503887333;4474.6420286377015;4513.413256276663;4513.571210734975;3521.4717792331357;3585.5697316321684;3590.98204508981;3623.80069096197;3641.7997010164695;1043.3791893823163;1045.6549338718205;1047.36634336227;1050.4327663062013;1055.757175849559;1391.5547024951918;1393.5958572014206;1412.6750847305177;1417.0930604413184;1418.4822539772908;7508.962455187689;7672.386209103258;7684.462087653922;7685.807854803675;7686.884696729554;1117.3742704085737;1129.170060005895;1133.195431243826;1135.6781414362956;1173.6596387047662;5998.25021872266;6006.039033754666;6044.153818465418;6048.546359023091;6059.666718330446;9106.180443760093;9667.903320966841;9670.226381889432;9755.951220243995;9787.461689606998;9556.617735290649;9632.422054676741;9664.9033509664;9673;9687.370320929118;7303.59830209333;7622.542647441061;7693.346065584376;7701.345385642171;7704.691812327556;7269.091363579552;7274.345308922222;7387.298206670358;7392.4086073115095;7392.741254056083;8499.277561407349;8528.616212270339;8545.74362769118;8602.741917742478;8709.608067636846;8692.869606955774;8908.5991130398;8917.28661707075;8940.776480588038;8948.821023579621;5979.940200598112;6130.386961303834;6376;6798.728050878108;6899.586024838526;7302.3792977597495;7304.780856574312;7340.632968351668;7341.926580734124;7342.926570734438;6703.530752847254;6801.319868013159;6801.931980680328;6910.412614927787;6959.130108736408;6544;6621.304763000008;6684.665766711548;6691.431228345645;6804.6257455840405;6883.242843287134;6943.9652801735665;6966.059581956371;6966.303369662993;6969.9303006969285;6611.801645950629;6613.834654133685;6631;6653.600783952978;6671.26616072222;6822.420094292041;6822.795316140524;6839.179298484214;6840.042394064934;6848.760293389708 11:38:16 INFO - PROCESS | 16407 | |4;prototype.html;341.38380223696225;346.07770292171364;346.8508541327228;347.9495473156392;355.8861164427381;5803.984302747023;5835.153902684108;5848;5848.415158484155;5849.619774714641;5775.509081728058;5787.13193021046;5840.474357307841;5860.355360910296;5872.031114866053;4317.222899878021;4414.624756895668;4521.706089104197;4534.229181039232;4571.200039993005;4538.795754191069;4548.567886050836;4562.8631141065825;4563.8630841074655;4564.680472366936;4460.107978404316;4501.797419116131;4502.077074199798;4509.932351014738;4517.774111294422;4294.076773493698;4386.144701783153;4481.820727170909;4488.371627972087;4503.549645035503;3959.6040395960463;3961.1681546875193;3972.9006774830573;3973.046468847456;3983.462232598591;5643.943560564383;5651.943480565183;5654.37801841797;5657.8019769307875;5668.121441176624;5257.8159764408065;5261.053010458116;5299.072662284085;5301.761420736076;5304.17785243284;6163.075538669191;6163.3528479509905;6165.445109940127;6165.784197553109;6171.907421388682;4174.290370636999;4288.828446862153;4306.923269182705;4417.028253784162;4430.202563538562;6414.550981431302;6441.935580644181;6453.064305675651;6466.515011374118;6476.319986401407;4415;4419.315006174048;4419.977900110479;4420.270655341897;4422.601965823092;4472.08322293929;4472.284434490466;4476.574725401082;4478.48497422794;4478.641708663299;5151.484851514893;5153.742312884341;5161.200013997836;5163.586913046947;5169.663971841894;6043.576949613573;6210.658413787195;6229.657368844757;6229.750809967551;6241.96879015602;1556.385227834999;1561.9765703514456;1573.7639354096978;1576.109498133551;1576.2276484522502;1003.6437064841876;1025.379645314574;1045.440689231273;1069.2194697870598;1070.175964507325;5971.462568368781;5972.134040564094;5981.0729336952845;5983.1623572699855;6000;6336.271328797247;6337.461315788118;6337.9683101585115;6344.936550634527;6352.14246076783;5972.910406343908;5976.7908123215475;5979.611325263844;5985.970070149709;5986.3714309997695;3384.1370450534955;3406.199543107368;3408.8466019028706;3412.3004784019217;3415.8292085395633;6492.707828147744;6649.135612370361;6656.234533028667;6661.233958094785;6665.500087493458;6457.321981192001;6483.124778154983;6487.6756162191705;6492.09110724499;6501.642409667514;6637.601743895381;6645.335466453413;6648.700808463534;6650.501212408992;6652.966735166293;6327.114204011534;6332.430081292706;6333.303336633059;6336.144620476177;6338;6100.725467353891;6238.844028899314;6243.8126856194385;6246.406591373812;6247.937520624736;6617.470602351704;6638.468922486093;6639.6680165992475;6646.734130634721;6648.601083934979;4346.47842258931;4365.367021781887;4366.890827729332;4367.2793988992735;4373.497047839412;6297.2128483939505;6331.430171284606;6332.715027823667;6337;6338.619682819046;6144.938550614615;6169;6171.413715697002;6171.9691401542705;6174.969125154345;6003.939960600338;6114.327423983447;6255.40573645503;6268.341824108403;6275.74897004133;6111.419415155553;6164.137020816999;6165.136880836776;6171.59884607499;6171.783987560414;6292.559520833681;6298.968505157445;6306.180196574416;6311.431971122621;6313.96843015782;5871.706414679164;5980.282366116094;6156.26124865019;6159.907601386072;6162.630242185483 11:38:16 INFO - PROCESS | 16407 | |5;yui.html;767.9808004799881;837.1126605797855;852.7569642651846;856.6016802186986;861.5132450165657;14330.641733956656;14508.854911450895;14520;14524.927375363108;14530.128192308443;12428;13801.171929684226;13859.514916977907;13881.791773123387;13883.09759865608;841.7937605286698;852.2117041736369;857.7126662568016;857.8412993596173;858.2876212743439;844.586152785137;853.7438768369495;853.8377708235446;853.8591132463137;855.055164043732;893.6738090596917;893.8882639670041;894.4454438248296;895.0870112485261;897.2552781191628;886.8315020146184;887.973360799177;888.3204348673303;888.4447220487195;888.9911100888972;651.0299653516226;651.8891788395985;652.0382435907;652.2368828470701;652.373721227622;13289.468421263138;13302.467901283937;13382.799258011137;13384.665383365396;13398.598042058753;13399.330033498383;13447.125936814076;13504.864951350557;13509.121907076009;13550.661233469144;10949.507272172772;10988.285761425483;11237.157213209042;11397.202195846294;11420.486078126503;4413.470383553994;4453.465584129893;4523.25366314561;4582.450105987269;4684.531546845288;54791.178132328045;55969.44030559683;56182.719086404715;56238;56540.434595653925;10689.786204275872;10769.730756731144;10898.128149748001;10907;11008.504617292241;18972.33596824132;18978.52553686169;18991.240350386106;18998.240070397307;19002;8158.673653053811;8305.169483051646;8422.831543369099;8655.91344086551;8686.86969695455;4853.277051966079;4885.340479035285;4952.826651067196;5000.049990501793;5002.89994200114;3452.188735647121;3455.447128459434;3457.7233821294235;3470.774399664014;3482.89551313461;598.6647477412663;599.9070144127667;608.5192697768713;609.9298580663192;614.5698011392044;750.1410884537174;751.6241879060469;757.4886951307845;776.2625505769541;778.5762752158145;9958.751031224278;9964.402135871871;10042.297039207186;10044.29689921713;10152;608.358182117861;672.4485921544286;673.2157037051779;754.0348354106752;765.043695380774;4659.720416775004;4666.136764698542;4688.203005489075;4700.2009658358165;4746.169420351424;62481;63593.45626174994;64147.358526415075;64493.67753161204;64669.67665161738;53850;54867.17699234515;55190.72404637951;56284;56917.43082569121;50591.49408505868;51424.48575514272;51592.22611660828;51778;51870.22194667158;9206.769830754285;9255.167034966886;9314.161725444743;9346.766330841512;9354.298427618092;38401.6159838398;38983;39273.214535708554;39810.402843956785;40158.79920600495;48457.27314090362;50415;50463.49536504588;51055.234171486714;51277;11260.7747845041;11282.492287847232;12632.2420654761;12659.050571207381;12955.157914735511;13709.451621935012;14169.716605668034;14193.574192774233;15008.849911501182;15665.138417386697;13174.934125329311;13223.867761322648;13237;13734.313284335944;14018.369173387018;12781.872181278068;13662.11196272239;13788.241646709528;14627.853721463074;14629.926850366106;13548.254845983565;13593.388297526833;13741.450341986209;14585.854141458449;14591.124532528082;10165.796684066425;10363.170946324426;10392.636257731245;10506.106980906708;10595.523201455799;10799.190060745632;11211.66365009051;11226;11233.550657973916;11322.37726925027 11:38:16 INFO - PROCESS | 16407 | __end_tp_report 11:38:16 INFO - PROCESS | 16407 | __start_cc_report 11:38:16 INFO - PROCESS | 16407 | _x_x_mozilla_cycle_collect,733 11:38:16 INFO - PROCESS | 16407 | __end_cc_report 11:38:16 INFO - PROCESS | 16407 | __startTimestamp1458239895998__endTimestamp 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | ------- Summary: start ------- 11:38:16 INFO - PROCESS | 16407 | Number of tests: 6 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#0] dojo.html Cycles:165 Average:5131.86 Median:5299.52 stddev:569.20 (10.7%) stddev-sans-first:546.23 11:38:16 INFO - PROCESS | 16407 | Values: 3017.0 3054.0 3090.4 3090.8 3124.3 5036.1 5165.3 5167.3 5205.5 5222.3 5156.7 5209.6 5212.2 5228.7 5249.1 4642.7 4676.1 4703.8 4759.9 4798.9 4703.8 4730.6 4750.7 4781.7 4818.7 4600.4 4611.6 4676.7 4692.0 4707.5 4644.4 4656.7 4668.0 4681.0 4699.1 4551.1 4653.5 4662.5 4662.8 4697.2 5034.3 5100.3 5105.4 5106.3 5127.5 5503.6 5512.9 5513.8 5524.8 5529.5 5389.8 5531.6 5539.8 5540.9 5544.3 5099.5 5123.6 5128.6 5143.2 5170.0 5572.1 5573.3 5575.1 5581.7 5585.4 5307.2 5369.2 5382.8 5389.9 5401.6 5567.5 5576.7 5590.9 5598.6 5638.3 5509.3 5523.9 5524.1 5524.1 5529.6 5293.1 5383.5 5439.8 5504.4 5565.7 4235.4 4238.1 4241.5 4279.3 4280.3 3790.5 3799.3 3807.2 3827.5 3837.9 5164.7 5198.3 5235.3 5293.5 5295.6 5514.5 5518.2 5539.4 5540.9 5543.2 5228.3 5243.3 5249.3 5256.1 5298.6 4667.4 4726.8 4810.5 4813.6 4814.9 5745.8 5759.1 5762.0 5765.0 5771.2 5488.3 5505.4 5509.9 5514.4 5547.6 5571.9 5783.4 5817.5 5827.6 5874.8 5449.6 5457.2 5458.6 5463.0 5464.0 5405.4 5534.0 5544.3 5547.7 5597.3 5401.5 5451.8 5452.6 5489.7 5502.9 5327.4 5344.1 5345.5 5361.1 5365.4 5202.4 5247.8 5285.8 5308.9 5362.4 5393.9 5406.9 5407.5 5438.2 5454.1 5289.4 5291.1 5292.2 5299.5 5341.6 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#1] ext.html Cycles:180 Average:50859.21 Median:18929.67 stddev:93145.27 (492.1%) stddev-sans-first:93329.94 11:38:16 INFO - PROCESS | 16407 | Values: 537.0 564.5 568.4 582.2 599.6 29695.4 30146.7 38672.2 38731.6 38811.2 41843.4 42122.0 42259.8 42283.4 42344.2 7539.9 8533.9 8632.1 8722.4 8722.5 10228.1 10471.8 10473.1 10474.3 10477.8 10236.8 10322.2 10330.0 10336.9 10372.8 10210.5 10229.9 10294.1 10298.5 10315.1 10075.5 10255.1 10258.2 10260.2 10265.8 41000.0 41201.0 41295.6 41298.4 41327.8 3363.8 3448.5 3493.2 3530.6 3900.8 31838.2 32380.2 32465.4 32528.3 32699.8 3932.8 4002.7 4014.0 4118.8 4121.2 329371.0 330245.0 330257.0 330990.3 331275.0 46403.4 46919.3 46923.5 46958.3 57526.0 45544.3 45583.5 45676.0 45732.5 45750.3 13358.1 13374.2 13421.7 13453.0 13486.2 9657.8 10557.8 10669.0 10751.2 10790.5 15122.5 15222.5 15407.8 15633.6 15680.0 5792.3 5856.9 5902.6 5968.2 5981.3 1003.5 1073.1 1102.6 1110.1 1130.0 28656.3 28673.7 29242.3 29410.4 29515.9 1082.2 1093.5 1095.3 1146.7 1240.3 15118.0 15590.3 15597.5 15628.6 15761.9 427369.0 428373.0 428628.0 433269.0 433391.0 58076.7 58614.0 58767.4 58793.2 58825.4 1196.2 1305.8 1325.8 1400.6 1476.8 29540.6 30791.2 33501.3 33540.0 33873.3 44949.8 45021.5 45485.0 46397.5 46704.5 280645.0 284741.0 286072.0 286305.0 286523.0 30123.2 34410.8 34611.0 34959.7 35624.5 42442.6 42526.4 42596.6 42736.6 42856.0 35016.0 35084.0 37519.6 37931.1 38244.6 37493.7 37948.2 38348.6 39043.9 39264.2 39892.2 40225.2 40258.6 40813.2 40966.8 33842.2 33847.5 34857.5 35089.6 35269.6 24967.9 25256.0 25318.5 25383.5 25409.7 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#2] jquery.html Cycles:180 Average:28367.98 Median:478.27 stddev:86969.15 (18184.3%) stddev-sans-first:87187.69 11:38:16 INFO - PROCESS | 16407 | Values: 357.2 361.4 368.7 373.2 375.2 16984.9 17350.8 18041.4 18252.7 18353.9 17757.1 18151.2 18708.7 18738.7 18770.7 5383.2 5521.8 5546.3 5558.4 5559.3 4030.9 5511.2 5890.0 6102.3 6124.4 6014.1 6048.9 6069.5 6087.9 6089.3 5953.6 5961.2 6035.1 6170.9 6179.9 3700.3 5207.9 5379.5 5387.1 5445.5 20319.3 20327.0 20443.5 21997.2 22128.8 2162.7 2725.3 2996.1 3009.2 3083.3 9775.4 9777.5 9788.7 9837.9 9905.8 1931.3 2015.2 2024.9 2055.9 2078.5 71357.3 72714.0 72855.6 73521.3 73921.3 10950.5 11083.6 11100.8 11103.7 11292.7 14355.1 14417.5 14503.8 14530.8 14557.9 7385.7 7506.3 7556.4 7589.9 7612.0 6987.4 7039.0 7115.5 7170.6 7177.7 4663.7 4717.4 4737.5 4806.5 4808.5 1704.2 1748.3 1767.1 1805.5 1808.4 480.6 486.1 490.5 899.4 1075.8 10658.7 11239.0 11565.4 11620.4 11654.6 477.4 479.1 490.2 491.2 494.6 5951.4 6064.7 6140.6 6144.9 6179.4 520529.0 521382.0 533903.0 534302.0 540197.0 79124.2 79788.2 81088.6 81263.0 81973.2 512.8 513.3 516.1 516.4 518.2 10856.9 10938.4 11034.6 11183.7 11227.0 35773.8 35906.8 36247.3 36577.3 36639.8 52000.0 52065.5 52068.2 52129.5 52203.0 8067.3 8119.1 8134.2 8276.9 8282.5 11557.9 11725.8 12068.7 12191.9 12577.9 10573.0 10640.0 10813.7 10848.5 11244.0 10650.5 10764.0 10772.6 10787.8 10968.3 10329.4 10984.7 11065.1 11305.0 11387.0 7831.7 8055.0 8099.7 8195.3 8244.5 9809.5 11257.6 11398.9 11432.5 11452.3 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#3] mootools.html Cycles:180 Average:5490.72 Median:6095.03 stddev:2790.79 (45.8%) stddev-sans-first:2781.03 11:38:16 INFO - PROCESS | 16407 | Values: 1323.4 1463.3 1463.7 1632.6 1793.6 7435.9 7589.1 7622.3 7628.5 7629.0 7550.1 7575.8 7631.0 7647.7 7648.6 1926.7 2203.6 2251.5 2276.4 2276.4 2220.7 2240.4 2240.6 2243.6 2250.1 2144.7 2146.8 2217.1 2218.4 2221.5 2246.0 2279.8 2284.1 2290.5 2291.5 2236.6 2238.9 2266.8 2269.9 2271.4 7814.3 7820.5 7847.6 7848.7 7853.3 4829.9 4874.5 4899.9 4903.5 4931.9 3317.7 3325.3 3379.6 3441.8 3457.9 1023.9 1049.9 1072.6 2031.2 2049.1 10322.3 10340.8 10341.6 10383.0 10388.7 4170.6 4238.7 4264.9 4289.3 4294.6 8162.0 8204.8 8210.4 8213.2 8217.0 4835.6 4868.2 4886.5 4897.9 4910.3 3850.7 4388.8 4474.6 4513.4 4513.6 3521.5 3585.6 3591.0 3623.8 3641.8 1043.4 1045.7 1047.4 1050.4 1055.8 1391.6 1393.6 1412.7 1417.1 1418.5 7509.0 7672.4 7684.5 7685.8 7686.9 1117.4 1129.2 1133.2 1135.7 1173.7 5998.3 6006.0 6044.2 6048.5 6059.7 9106.2 9667.9 9670.2 9756.0 9787.5 9556.6 9632.4 9664.9 9673.0 9687.4 7303.6 7622.5 7693.3 7701.3 7704.7 7269.1 7274.3 7387.3 7392.4 7392.7 8499.3 8528.6 8545.7 8602.7 8709.6 8692.9 8908.6 8917.3 8940.8 8948.8 5979.9 6130.4 6376.0 6798.7 6899.6 7302.4 7304.8 7340.6 7341.9 7342.9 6703.5 6801.3 6801.9 6910.4 6959.1 6544.0 6621.3 6684.7 6691.4 6804.6 6883.2 6944.0 6966.1 6966.3 6969.9 6611.8 6613.8 6631.0 6653.6 6671.3 6822.4 6822.8 6839.2 6840.0 6848.8 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#4] prototype.html Cycles:180 Average:5191.60 Median:5921.75 stddev:1556.01 (26.3%) stddev-sans-first:1517.19 11:38:16 INFO - PROCESS | 16407 | Values: 341.4 346.1 346.9 347.9 355.9 5804.0 5835.2 5848.0 5848.4 5849.6 5775.5 5787.1 5840.5 5860.4 5872.0 4317.2 4414.6 4521.7 4534.2 4571.2 4538.8 4548.6 4562.9 4563.9 4564.7 4460.1 4501.8 4502.1 4509.9 4517.8 4294.1 4386.1 4481.8 4488.4 4503.5 3959.6 3961.2 3972.9 3973.0 3983.5 5643.9 5651.9 5654.4 5657.8 5668.1 5257.8 5261.1 5299.1 5301.8 5304.2 6163.1 6163.4 6165.4 6165.8 6171.9 4174.3 4288.8 4306.9 4417.0 4430.2 6414.6 6441.9 6453.1 6466.5 6476.3 4415.0 4419.3 4420.0 4420.3 4422.6 4472.1 4472.3 4476.6 4478.5 4478.6 5151.5 5153.7 5161.2 5163.6 5169.7 6043.6 6210.7 6229.7 6229.8 6242.0 1556.4 1562.0 1573.8 1576.1 1576.2 1003.6 1025.4 1045.4 1069.2 1070.2 5971.5 5972.1 5981.1 5983.2 6000.0 6336.3 6337.5 6338.0 6344.9 6352.1 5972.9 5976.8 5979.6 5986.0 5986.4 3384.1 3406.2 3408.8 3412.3 3415.8 6492.7 6649.1 6656.2 6661.2 6665.5 6457.3 6483.1 6487.7 6492.1 6501.6 6637.6 6645.3 6648.7 6650.5 6653.0 6327.1 6332.4 6333.3 6336.1 6338.0 6100.7 6238.8 6243.8 6246.4 6247.9 6617.5 6638.5 6639.7 6646.7 6648.6 4346.5 4365.4 4366.9 4367.3 4373.5 6297.2 6331.4 6332.7 6337.0 6338.6 6144.9 6169.0 6171.4 6172.0 6175.0 6003.9 6114.3 6255.4 6268.3 6275.7 6111.4 6164.1 6165.1 6171.6 6171.8 6292.6 6299.0 6306.2 6311.4 6314.0 5871.7 5980.3 6156.3 6159.9 6162.6 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - PROCESS | 16407 | [#5] yui.html Cycles:180 Average:15399.45 Median:4694.20 stddev:17799.18 (379.2%) stddev-sans-first:17815.20 11:38:16 INFO - PROCESS | 16407 | Values: 768.0 837.1 852.8 856.6 861.5 14330.6 14508.9 14520.0 14524.9 14530.1 12428.0 13801.2 13859.5 13881.8 13883.1 841.8 852.2 857.7 857.8 858.3 844.6 853.7 853.8 853.9 855.1 893.7 893.9 894.4 895.1 897.3 886.8 888.0 888.3 888.4 889.0 651.0 651.9 652.0 652.2 652.4 13289.5 13302.5 13382.8 13384.7 13398.6 13399.3 13447.1 13504.9 13509.1 13550.7 10949.5 10988.3 11237.2 11397.2 11420.5 4413.5 4453.5 4523.3 4582.5 4684.5 54791.2 55969.4 56182.7 56238.0 56540.4 10689.8 10769.7 10898.1 10907.0 11008.5 18972.3 18978.5 18991.2 18998.2 19002.0 8158.7 8305.2 8422.8 8655.9 8686.9 4853.3 4885.3 4952.8 5000.0 5002.9 3452.2 3455.4 3457.7 3470.8 3482.9 598.7 599.9 608.5 609.9 614.6 750.1 751.6 757.5 776.3 778.6 9958.8 9964.4 10042.3 10044.3 10152.0 608.4 672.4 673.2 754.0 765.0 4659.7 4666.1 4688.2 4700.2 4746.2 62481.0 63593.5 64147.4 64493.7 64669.7 53850.0 54867.2 55190.7 56284.0 56917.4 50591.5 51424.5 51592.2 51778.0 51870.2 9206.8 9255.2 9314.2 9346.8 9354.3 38401.6 38983.0 39273.2 39810.4 40158.8 48457.3 50415.0 50463.5 51055.2 51277.0 11260.8 11282.5 12632.2 12659.1 12955.2 13709.5 14169.7 14193.6 15008.8 15665.1 13174.9 13223.9 13237.0 13734.3 14018.4 12781.9 13662.1 13788.2 14627.9 14629.9 13548.3 13593.4 13741.5 14585.9 14591.1 10165.8 10363.2 10392.6 10506.1 10595.5 10799.2 11211.7 11226.0 11233.6 11322.4 11:38:16 INFO - PROCESS | 16407 | -------- Summary: end -------- 11:38:16 INFO - PROCESS | 16407 | 11:38:16 INFO - TEST-INFO | 16407: exit 0 11:38:16 INFO - TEST-OK | dromaeo_css | took 1110797ms 11:38:16 INFO - TEST-START | kraken 11:38:16 INFO - operating with platform_type : linux_ 11:38:16 INFO - Initialising browser for kraken test... 11:38:16 INFO - TEST-INFO | started process 16595 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7vs4Vw/profile http://localhost:44889/getInfo.html) 11:38:20 INFO - PROCESS | 16595 | __metrics Screen width/height:1600/1200 11:38:20 INFO - PROCESS | 16595 | colorDepth:24 11:38:20 INFO - PROCESS | 16595 | Browser inner width/height: 1024/697 11:38:20 INFO - PROCESS | 16595 | __metrics 11:38:21 ERROR - PROCESS | 16595 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:38:21 INFO - PROCESS | 16595 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:38:22 INFO - TEST-INFO | 16595: exit 0 11:38:22 INFO - Browser initialized. 11:38:22 INFO - Running cycle 1/1 for kraken test... 11:38:22 INFO - TEST-INFO | started process 16676 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7vs4Vw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:34 INFO - PROCESS | 16676 | RSS: Main: 153022464 11:38:34 INFO - PROCESS | 16676 | 11:38:36 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:37 INFO - PROCESS | 16676 | RSS: Main: 196157440 11:38:37 INFO - PROCESS | 16676 | 11:38:40 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-dft) 11:38:40 INFO - PROCESS | 16676 | RSS: Main: 185958400 11:38:40 INFO - PROCESS | 16676 | 11:38:43 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-fft) 11:38:44 INFO - PROCESS | 16676 | RSS: Main: 169574400 11:38:44 INFO - PROCESS | 16676 | 11:38:46 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44889/tests/kraken/driver.html?testName=audio-oscillator) 11:38:46 INFO - PROCESS | 16676 | RSS: Main: 173780992 11:38:46 INFO - PROCESS | 16676 | 11:38:48 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:49 INFO - PROCESS | 16676 | RSS: Main: 175648768 11:38:49 INFO - PROCESS | 16676 | 11:38:52 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:53 INFO - PROCESS | 16676 | RSS: Main: 174510080 11:38:53 INFO - PROCESS | 16676 | 11:38:56 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44889/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:56 INFO - PROCESS | 16676 | RSS: Main: 175673344 11:38:56 INFO - PROCESS | 16676 | 11:38:59 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44889/tests/kraken/driver.html?testName=json-parse-financial) 11:39:00 INFO - PROCESS | 16676 | RSS: Main: 174522368 11:39:00 INFO - PROCESS | 16676 | 11:39:01 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:39:02 INFO - PROCESS | 16676 | RSS: Main: 185307136 11:39:02 INFO - PROCESS | 16676 | 11:39:04 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:39:04 INFO - PROCESS | 16676 | RSS: Main: 184025088 11:39:04 INFO - PROCESS | 16676 | 11:39:06 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:39:07 INFO - PROCESS | 16676 | RSS: Main: 189800448 11:39:07 INFO - PROCESS | 16676 | 11:39:09 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:39:10 INFO - PROCESS | 16676 | RSS: Main: 199000064 11:39:10 INFO - PROCESS | 16676 | 11:39:12 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:13 INFO - PROCESS | 16676 | RSS: Main: 198201344 11:39:13 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | Cycle 1(1): loaded http://localhost:44889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44889/tests/kraken/driver.html?testName=ai-astar) 11:39:15 INFO - PROCESS | 16676 | RSS: Main: 258605056 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | __start_tp_report 11:39:15 INFO - PROCESS | 16676 | _x_x_mozilla_page_load 11:39:15 INFO - PROCESS | 16676 | _x_x_mozilla_page_load_details 11:39:15 INFO - PROCESS | 16676 | |i|pagename|runs| 11:39:15 INFO - PROCESS | 16676 | |0;ai-astar;109;110;104;109;110;109;98;109;108;109 11:39:15 INFO - PROCESS | 16676 | |1;audio-beat-detection;151;131;151;166;127;157;165;126;178;125 11:39:15 INFO - PROCESS | 16676 | |2;audio-dft;161;160;162;161;161;161;161;165;162;162 11:39:15 INFO - PROCESS | 16676 | |3;audio-fft;76;73;102;91;75;76;76;107;93;74 11:39:15 INFO - PROCESS | 16676 | |4;audio-oscillator;92;92;138;92;92;93;145;92;92;148 11:39:15 INFO - PROCESS | 16676 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;117;117;117 11:39:15 INFO - PROCESS | 16676 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;145;145 11:39:15 INFO - PROCESS | 16676 | |7;imaging-desaturate;95;95;96;95;94;95;95;95;95;96 11:39:15 INFO - PROCESS | 16676 | |8;json-parse-financial;60;60;61;61;59;60;59;69;58;59 11:39:15 INFO - PROCESS | 16676 | |9;json-stringify-tinderbox;60;60;59;60;61;60;60;59;60;59 11:39:15 INFO - PROCESS | 16676 | |10;stanford-crypto-aes;78;79;80;78;78;78;78;85;79;79 11:39:15 INFO - PROCESS | 16676 | |11;stanford-crypto-ccm;114;112;112;111;126;112;123;111;120;111 11:39:15 INFO - PROCESS | 16676 | |12;stanford-crypto-pbkdf2;144;137;145;141;140;133;141;142;139;140 11:39:15 INFO - PROCESS | 16676 | |13;stanford-crypto-sha256-iterative;63;66;65;63;64;66;63;63;71;65 11:39:15 INFO - PROCESS | 16676 | __end_tp_report 11:39:15 INFO - PROCESS | 16676 | __start_cc_report 11:39:15 INFO - PROCESS | 16676 | _x_x_mozilla_cycle_collect,1089 11:39:15 INFO - PROCESS | 16676 | __end_cc_report 11:39:15 INFO - PROCESS | 16676 | __startTimestamp1458239955353__endTimestamp 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | ------- Summary: start ------- 11:39:15 INFO - PROCESS | 16676 | Number of tests: 14 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:3.75 (3.4%) stddev-sans-first:3.94 11:39:15 INFO - PROCESS | 16676 | Values: 109.0 110.0 104.0 109.0 110.0 109.0 98.0 109.0 108.0 109.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.00 stddev:19.30 (12.5%) stddev-sans-first:20.44 11:39:15 INFO - PROCESS | 16676 | Values: 151.0 131.0 151.0 166.0 127.0 157.0 165.0 126.0 178.0 125.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 11:39:15 INFO - PROCESS | 16676 | Values: 161.0 160.0 162.0 161.0 161.0 161.0 161.0 165.0 162.0 162.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:12.81 (16.9%) stddev-sans-first:13.23 11:39:15 INFO - PROCESS | 16676 | Values: 76.0 73.0 102.0 91.0 75.0 76.0 76.0 107.0 93.0 74.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:92.00 stddev:25.01 (27.2%) stddev-sans-first:25.88 11:39:15 INFO - PROCESS | 16676 | Values: 92.0 92.0 138.0 92.0 92.0 93.0 145.0 92.0 92.0 148.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:39:15 INFO - PROCESS | 16676 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:39:15 INFO - PROCESS | 16676 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:39:15 INFO - PROCESS | 16676 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:3.10 (5.2%) stddev-sans-first:3.28 11:39:15 INFO - PROCESS | 16676 | Values: 60.0 60.0 61.0 61.0 59.0 60.0 59.0 69.0 58.0 59.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 11:39:15 INFO - PROCESS | 16676 | Values: 60.0 60.0 59.0 60.0 61.0 60.0 60.0 59.0 60.0 59.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.15 (2.7%) stddev-sans-first:2.24 11:39:15 INFO - PROCESS | 16676 | Values: 78.0 79.0 80.0 78.0 78.0 78.0 78.0 85.0 79.0 79.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:113.00 stddev:5.63 (5.0%) stddev-sans-first:5.96 11:39:15 INFO - PROCESS | 16676 | Values: 114.0 112.0 112.0 111.0 126.0 112.0 123.0 111.0 120.0 111.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:141.00 stddev:3.43 (2.4%) stddev-sans-first:3.35 11:39:15 INFO - PROCESS | 16676 | Values: 144.0 137.0 145.0 141.0 140.0 133.0 141.0 142.0 139.0 140.0 11:39:15 INFO - PROCESS | 16676 | 11:39:15 INFO - PROCESS | 16676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.47 (3.8%) stddev-sans-first:2.52 11:39:15 INFO - PROCESS | 16676 | Values: 63.0 66.0 65.0 63.0 64.0 66.0 63.0 63.0 71.0 65.0 11:39:15 INFO - PROCESS | 16676 | -------- Summary: end -------- 11:39:15 INFO - PROCESS | 16676 | 11:39:16 INFO - TEST-INFO | 16676: exit 0 11:39:16 INFO - TEST-OK | kraken | took 59572ms 11:39:16 INFO - SUITE-END | took 1170s 11:39:16 INFO - Completed test suite (00:19:30) 11:39:16 INFO - javascript benchmark 11:39:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3017.0496293667493, 3054.0, 3090.3664748726515, 3090.8145511269327, 3124.265797537579, 5036.093503169428, 5165.328507294052, 5167.302414174081, 5205.505476979691, 5222.294990176325, 5156.690598564089, 5209.609279304048, 5212.192110222922, 5228.686278823273, 5249.107651699211, 4642.651801114913, 4676.111538807632, 4703.764811759398, 4759.857204283877, 4798.928016079762, 4703.811847526094, 4730.574248317651, 4750.738709370983, 4781.7370044647705, 4818.68678535894, 4600.42494688164, 4611.608013318855, 4676.672632915697, 4691.953080469186, 4707.458642256116, 4644.442666879962, 4656.720596764205, 4667.953320466786, 4681.040386720748, 4699.060187962387, 4551.089782043605, 4653.488116307203, 4662.510436404163, 4662.790174442158, 4697.248440249544, 5034.345535080416, 5100.336956195708, 5105.361829771278, 5106.285120083191, 5127.5385215330425, 5503.642263252916, 5512.869861678347, 5513.807016754395, 5524.806631767909, 5529.502344788948, 5389.83830485086, 5531.585131115183, 5539.778408863641, 5540.9168862467095, 5544.279243698334, 5099.5410413063, 5123.590112791005, 5128.589712822965, 5143.151380022292, 5170.0, 5572.080606699849, 5573.331200255995, 5575.080111781511, 5581.6930068845795, 5585.413531579125, 5307.203919412119, 5369.19462080691, 5382.811601593926, 5389.9191512127345, 5401.648892821954, 5567.47109024642, 5576.749046292926, 5590.91613625796, 5598.58010649203, 5638.323401191883, 5509.283793106951, 5523.861903452445, 5524.088525393265, 5524.14375771756, 5529.557635389159, 5293.073712100367, 5383.461653834585, 5439.755211015435, 5504.366997795225, 5565.693886836182, 4235.407043013981, 4238.0888109056705, 4241.512226093977, 4279.33670281107, 4280.250956082736, 3790.5261842269715, 3799.316123097869, 3807.162424266657, 3827.5215598050245, 3837.884863454101, 5164.690118592896, 5198.324217851655, 5235.345581802275, 5293.470652934676, 5295.602829787781, 5514.503694667499, 5518.172274158908, 5539.362973258127, 5540.944590554042, 5543.168524721244, 5228.346456692913, 5243.344581927259, 5249.317588713519, 5256.08018596744, 5298.629095963245, 4667.369905062841, 4726.787294571753, 4810.542998415145, 4813.638977076664, 4814.879628009257, 5745.770169193269, 5759.107338362561, 5762.0, 5765.048766953406, 5771.192033115283, 5488.313960754906, 5505.394406615189, 5509.917351239815, 5514.420985796594, 5547.583931205257, 5571.8885622288135, 5783.363829978614, 5817.476427121579, 5827.59206855533, 5874.823755287348, 5449.564034877121, 5457.181422786613, 5458.590605704509, 5463.0, 5464.0, 5405.378381486179, 5534.0, 5544.306961629796, 5547.667139971453, 5597.328320601554, 5401.4868587484125, 5451.754671039892, 5452.591055670761, 5489.725513724218, 5502.862428439321, 5327.440618735132, 5344.091504444332, 5345.492178243061, 5361.142217245222, 5365.38298095724, 5202.375714914235, 5247.763850626808, 5285.762140703754, 5308.867278318073, 5362.410134885237, 5393.919091213714, 5406.891862162656, 5407.459254074561, 5438.23864658956, 5454.127339625641, 5289.444608316071, 5291.074062039051, 5292.179712144623, 5299.5230429261555, 5341.62608617393], "unit": "score", "name": "dojo.html", "value": 5094.817088583616}, {"lowerIsBetter": false, "replicates": [536.9892602147958, 564.5088772767692, 568.4060157135792, 582.1878479521067, 599.5503372470647, 29695.40609187815, 30146.698533014664, 38672.22655546887, 38731.61268387315, 38811.22377552447, 41843.372349414785, 42122.0, 42259.78870105645, 42283.36574951378, 42344.15311693764, 7539.924600754004, 8533.91466085339, 8632.093630168836, 8722.38943273971, 8722.520261385622, 10228.079472847443, 10471.790564188712, 10473.057424831764, 10474.319169253975, 10477.790444191112, 10236.795264094713, 10322.174226061934, 10330.0, 10336.896631033705, 10372.844407333858, 10210.540525676362, 10229.897701023006, 10294.073533382032, 10298.53656585448, 10315.123214526775, 10075.496225188785, 10255.128314093312, 10258.179345652405, 10260.179185665129, 10265.846012309821, 41000.0, 41201.0, 41295.587044129476, 41298.38052429216, 41327.793361033, 3363.764536482447, 3448.517207590939, 3493.1616412061176, 3530.6292839251764, 3900.8049597520294, 31838.20404489883, 32380.190495237806, 32465.350692986245, 32528.349433011208, 32699.836500817582, 3932.7836968966694, 4002.6597739192202, 4013.9598604013877, 4118.794060296973, 4121.175764847013, 329371.0, 330245.0, 330257.0, 330990.3450482756, 331275.0, 46403.375881843975, 46919.29621055619, 46923.53076469192, 46958.295625565646, 57526.0, 45544.3168352475, 45583.54416455793, 45676.0, 45732.542674573495, 45750.313745293846, 13358.131721438076, 13374.197548147142, 13421.66445838862, 13453.0, 13486.190828550121, 9657.758556036155, 10557.841632375521, 10669.0, 10751.247412681194, 10790.51442685081, 15122.54632361031, 15222.543323700307, 15407.845921540866, 15633.60915977087, 15680.0, 5792.333881603585, 5856.8535786604825, 5902.612885971793, 5968.22413086296, 5981.312149102821, 1003.4731765822855, 1073.0878753059837, 1102.6030628973563, 1110.1451882050776, 1129.954801807935, 28656.283592909927, 28673.71326286752, 29242.268943276587, 29410.411791764043, 29515.85242073776, 1082.155918383662, 1093.4969913839564, 1095.3482677806692, 1146.7305183281921, 1240.342618412243, 15118.0, 15590.298436570154, 15597.454089107054, 15628.609284767972, 15761.921190394203, 427369.0, 428373.0, 428628.0, 433269.0, 433391.0, 58076.70961645165, 58614.0, 58767.41232587705, 58793.238777540275, 58825.41174588285, 1196.1985469735298, 1305.7584346895856, 1325.7613629546581, 1400.586826886071, 1476.8006319146778, 29540.556891646214, 30791.234003247733, 33501.32997340088, 33540.0, 33873.32253354968, 44949.77525112484, 45021.54978450305, 45485.0, 46397.53602464067, 46704.532954670016, 280645.0, 284741.0, 286072.0, 286305.0, 286523.0, 30123.246918827204, 34410.827945861114, 34611.0, 34959.65040349564, 35624.46563301501, 42442.57557424386, 42526.362104569074, 42596.5740342605, 42736.57263427326, 42856.0, 35016.0, 35084.0, 37519.62480375161, 37931.051723707125, 38244.61755382411, 37493.69024474362, 37948.24103517859, 38348.6165138345, 39043.852588107926, 39264.214715704955, 39892.2021559573, 40225.19549608933, 40258.597414025484, 40813.183736324514, 40966.79516602398, 33842.15394615056, 33847.492287616195, 34857.47713784245, 35089.64910350864, 35269.64730352664, 24967.87516062408, 25256.0, 25318.49363012766, 25383.492330152923, 25409.745902540737], "unit": "score", "name": "ext.html", "value": 18860.779527065097}, {"lowerIsBetter": false, "replicates": [357.20521838908434, 361.37842910194456, 368.71977297254085, 373.23673088533945, 375.17648760969684, 16984.915075424637, 17350.82649173508, 18041.368552100677, 18252.72620910684, 18353.90823045883, 17757.112144392795, 18151.183196756145, 18708.719369209473, 18738.718919216222, 18770.718439223423, 5383.2194331821765, 5521.751521181536, 5546.251256080438, 5558.360788509332, 5559.277293951781, 4030.879073627781, 5511.22842802008, 5889.970550147244, 6102.298235702907, 6124.448799608034, 6014.097885317194, 6048.879022419549, 6069.514438844903, 6087.878242435148, 6089.3301736809135, 5953.642781433106, 5961.165436838846, 6035.094735789645, 6170.8765824683705, 6179.907301390438, 3700.2599480104086, 5207.9479205207845, 5379.488948549882, 5387.057264978613, 5445.53712934401, 20319.288824891206, 20327.0, 20443.48891277715, 21997.23009694669, 22128.778712212992, 2162.675598660198, 2725.2914242296947, 2996.146098361978, 3009.20256132123, 3083.2908431060982, 9775.41347519144, 9777.46223957682, 9788.706338809847, 9837.90162098377, 9905.80188396228, 1931.3433432632971, 2015.2442833937273, 2024.8785072895673, 2055.876647401161, 2078.4596005038647, 71357.2864271361, 72714.0, 72855.63572182211, 73521.26478735197, 73921.28098659847, 10950.452477376099, 11083.556657733601, 11100.833487497694, 11103.666889993314, 11292.661220163409, 14355.066920650124, 14417.495387661382, 14503.782443263359, 14530.782038269434, 14557.927210364092, 7385.667644955883, 7506.28690274423, 7556.395488360918, 7589.8861517077285, 7611.961940190264, 6987.371136597731, 7039.0, 7115.501914865909, 7170.641467926583, 7177.677004534704, 4663.696859704109, 4717.386739723814, 4737.531365276706, 4806.543378379049, 4808.543188397097, 1704.2330951072067, 1748.3006797280934, 1767.098779622402, 1805.5305620538754, 1808.3851490493296, 480.60590315940595, 486.0667518364748, 490.5045903637352, 899.4243684042218, 1075.8166017380818, 10658.68023959267, 11239.0, 11565.421728913521, 11620.418979051014, 11654.592089276835, 477.4056299906569, 479.1255957876819, 490.2376804069635, 491.2116053733777, 494.6240856948673, 5951.404859514014, 6064.696765161724, 6140.5701600887505, 6144.938550614436, 6179.368479927286, 520529.0, 521382.0, 533903.0, 534302.0, 540197.0, 79124.20875791284, 79788.20211797807, 81088.59455702802, 81263.0, 81973.18026819774, 512.7538781384956, 513.2839688634334, 516.1303204101101, 516.431924882626, 518.1916210711303, 10856.945715271373, 10938.398388088413, 11034.613788517363, 11183.71387290472, 11227.045701115496, 35773.82113089522, 35906.82046589855, 36247.275054498234, 36577.26845463129, 36639.816800915825, 52000.0, 52065.479345207576, 52068.21897671614, 52129.47870521246, 52203.0, 8067.314278286177, 8119.106898241071, 8134.186581341818, 8276.875846862422, 8282.544460054754, 11557.884421156017, 11725.765484690088, 12068.698282543006, 12191.878081219074, 12577.87422125767, 10573.0, 10640.0, 10813.67558973232, 10848.457577120955, 11244.044256237985, 10650.520726567478, 10764.0, 10772.622958196738, 10787.784244315228, 10968.341899486057, 10329.380237185793, 10984.725381865517, 11065.059469945145, 11305.0, 11387.0, 7831.725889593837, 8054.959725201571, 8099.716509922125, 8195.303399211134, 8244.505329679998, 9809.509524523888, 11257.592800899887, 11398.94300528492, 11432.542698291974, 11452.312861228353], "unit": "score", "name": "jquery.html", "value": 8097.93323918647}, {"lowerIsBetter": false, "replicates": [1323.4110820684798, 1463.282991334246, 1463.656040830405, 1632.640819019816, 1793.5964408008192, 7435.888461673072, 7589.051368578927, 7622.3139917407425, 7628.50414723044, 7629.0, 7550.093988721347, 7575.848483030336, 7631.046119235096, 7647.732329368473, 7648.617569121549, 1926.6820974539185, 2203.636399994007, 2251.5271792923504, 2276.3626184668237, 2276.4422716434497, 2220.678001689754, 2240.4286906838734, 2240.574290884727, 2243.6410174372104, 2250.1112060736, 2144.6997420361163, 2146.7960543748395, 2217.135317226283, 2218.4121207879925, 2221.533477969628, 2246.0454306919496, 2279.794818466338, 2284.1434462076636, 2290.48464095578, 2291.541691661674, 2236.6421372580307, 2238.9216377426874, 2266.8186545076355, 2269.943251418711, 2271.44349634339, 7814.257645523666, 7820.530768153929, 7847.607619618996, 7848.68605255789, 7853.293203611703, 4829.903401931977, 4874.512548745132, 4899.926501102486, 4903.509649035103, 4931.876703082416, 3317.668233176687, 3325.3016866458074, 3379.645137260577, 3441.8451169697423, 3457.913552161191, 1023.9402218703606, 1049.942253176075, 1072.6406653770996, 2031.177373163871, 2049.067674208232, 10322.277440579162, 10340.793184136275, 10341.586336546528, 10383.0, 10388.688339349832, 4170.562090980464, 4238.660907127484, 4264.936025959551, 4289.292266775947, 4294.613484786384, 8162.0, 8204.794880127925, 8210.425270231026, 8213.178682131738, 8217.0, 4835.637327200474, 4868.221084626513, 4886.511348865085, 4897.926531102036, 4910.288008238786, 3850.7111966602615, 4388.802503887333, 4474.6420286377015, 4513.413256276663, 4513.571210734975, 3521.4717792331357, 3585.5697316321684, 3590.98204508981, 3623.80069096197, 3641.7997010164695, 1043.3791893823163, 1045.6549338718205, 1047.36634336227, 1050.4327663062013, 1055.757175849559, 1391.5547024951918, 1393.5958572014206, 1412.6750847305177, 1417.0930604413184, 1418.4822539772908, 7508.962455187689, 7672.386209103258, 7684.462087653922, 7685.807854803675, 7686.884696729554, 1117.3742704085737, 1129.170060005895, 1133.195431243826, 1135.6781414362956, 1173.6596387047662, 5998.25021872266, 6006.039033754666, 6044.153818465418, 6048.546359023091, 6059.666718330446, 9106.180443760093, 9667.903320966841, 9670.226381889432, 9755.951220243995, 9787.461689606998, 9556.617735290649, 9632.422054676741, 9664.9033509664, 9673.0, 9687.370320929118, 7303.59830209333, 7622.542647441061, 7693.346065584376, 7701.345385642171, 7704.691812327556, 7269.091363579552, 7274.345308922222, 7387.298206670358, 7392.4086073115095, 7392.741254056083, 8499.277561407349, 8528.616212270339, 8545.74362769118, 8602.741917742478, 8709.608067636846, 8692.869606955774, 8908.5991130398, 8917.28661707075, 8940.776480588038, 8948.821023579621, 5979.940200598112, 6130.386961303834, 6376.0, 6798.728050878108, 6899.586024838526, 7302.3792977597495, 7304.780856574312, 7340.632968351668, 7341.926580734124, 7342.926570734438, 6703.530752847254, 6801.319868013159, 6801.931980680328, 6910.412614927787, 6959.130108736408, 6544.0, 6621.304763000008, 6684.665766711548, 6691.431228345645, 6804.6257455840405, 6883.242843287134, 6943.9652801735665, 6966.059581956371, 6966.303369662993, 6969.9303006969285, 6611.801645950629, 6613.834654133685, 6631.0, 6653.600783952978, 6671.26616072222, 6822.420094292041, 6822.795316140524, 6839.179298484214, 6840.042394064934, 6848.760293389708], "unit": "score", "name": "mootools.html", "value": 4558.325398322861}, {"lowerIsBetter": false, "replicates": [341.38380223696225, 346.07770292171364, 346.8508541327228, 347.9495473156392, 355.8861164427381, 5803.984302747023, 5835.153902684108, 5848.0, 5848.415158484155, 5849.619774714641, 5775.509081728058, 5787.13193021046, 5840.474357307841, 5860.355360910296, 5872.031114866053, 4317.222899878021, 4414.624756895668, 4521.706089104197, 4534.229181039232, 4571.200039993005, 4538.795754191069, 4548.567886050836, 4562.8631141065825, 4563.8630841074655, 4564.680472366936, 4460.107978404316, 4501.797419116131, 4502.077074199798, 4509.932351014738, 4517.774111294422, 4294.076773493698, 4386.144701783153, 4481.820727170909, 4488.371627972087, 4503.549645035503, 3959.6040395960463, 3961.1681546875193, 3972.9006774830573, 3973.046468847456, 3983.462232598591, 5643.943560564383, 5651.943480565183, 5654.37801841797, 5657.8019769307875, 5668.121441176624, 5257.8159764408065, 5261.053010458116, 5299.072662284085, 5301.761420736076, 5304.17785243284, 6163.075538669191, 6163.3528479509905, 6165.445109940127, 6165.784197553109, 6171.907421388682, 4174.290370636999, 4288.828446862153, 4306.923269182705, 4417.028253784162, 4430.202563538562, 6414.550981431302, 6441.935580644181, 6453.064305675651, 6466.515011374118, 6476.319986401407, 4415.0, 4419.315006174048, 4419.977900110479, 4420.270655341897, 4422.601965823092, 4472.08322293929, 4472.284434490466, 4476.574725401082, 4478.48497422794, 4478.641708663299, 5151.484851514893, 5153.742312884341, 5161.200013997836, 5163.586913046947, 5169.663971841894, 6043.576949613573, 6210.658413787195, 6229.657368844757, 6229.750809967551, 6241.96879015602, 1556.385227834999, 1561.9765703514456, 1573.7639354096978, 1576.109498133551, 1576.2276484522502, 1003.6437064841876, 1025.379645314574, 1045.440689231273, 1069.2194697870598, 1070.175964507325, 5971.462568368781, 5972.134040564094, 5981.0729336952845, 5983.1623572699855, 6000.0, 6336.271328797247, 6337.461315788118, 6337.9683101585115, 6344.936550634527, 6352.14246076783, 5972.910406343908, 5976.7908123215475, 5979.611325263844, 5985.970070149709, 5986.3714309997695, 3384.1370450534955, 3406.199543107368, 3408.8466019028706, 3412.3004784019217, 3415.8292085395633, 6492.707828147744, 6649.135612370361, 6656.234533028667, 6661.233958094785, 6665.500087493458, 6457.321981192001, 6483.124778154983, 6487.6756162191705, 6492.09110724499, 6501.642409667514, 6637.601743895381, 6645.335466453413, 6648.700808463534, 6650.501212408992, 6652.966735166293, 6327.114204011534, 6332.430081292706, 6333.303336633059, 6336.144620476177, 6338.0, 6100.725467353891, 6238.844028899314, 6243.8126856194385, 6246.406591373812, 6247.937520624736, 6617.470602351704, 6638.468922486093, 6639.6680165992475, 6646.734130634721, 6648.601083934979, 4346.47842258931, 4365.367021781887, 4366.890827729332, 4367.2793988992735, 4373.497047839412, 6297.2128483939505, 6331.430171284606, 6332.715027823667, 6337.0, 6338.619682819046, 6144.938550614615, 6169.0, 6171.413715697002, 6171.9691401542705, 6174.969125154345, 6003.939960600338, 6114.327423983447, 6255.40573645503, 6268.341824108403, 6275.74897004133, 6111.419415155553, 6164.137020816999, 6165.136880836776, 6171.59884607499, 6171.783987560414, 6292.559520833681, 6298.968505157445, 6306.180196574416, 6311.431971122621, 6313.96843015782, 5871.706414679164, 5980.282366116094, 6156.26124865019, 6159.907601386072, 6162.630242185483], "unit": "score", "name": "prototype.html", "value": 4689.867050750926}, {"lowerIsBetter": false, "replicates": [767.9808004799881, 837.1126605797855, 852.7569642651846, 856.6016802186986, 861.5132450165657, 14330.641733956656, 14508.854911450895, 14520.0, 14524.927375363108, 14530.128192308443, 12428.0, 13801.171929684226, 13859.514916977907, 13881.791773123387, 13883.09759865608, 841.7937605286698, 852.2117041736369, 857.7126662568016, 857.8412993596173, 858.2876212743439, 844.586152785137, 853.7438768369495, 853.8377708235446, 853.8591132463137, 855.055164043732, 893.6738090596917, 893.8882639670041, 894.4454438248296, 895.0870112485261, 897.2552781191628, 886.8315020146184, 887.973360799177, 888.3204348673303, 888.4447220487195, 888.9911100888972, 651.0299653516226, 651.8891788395985, 652.0382435907, 652.2368828470701, 652.373721227622, 13289.468421263138, 13302.467901283937, 13382.799258011137, 13384.665383365396, 13398.598042058753, 13399.330033498383, 13447.125936814076, 13504.864951350557, 13509.121907076009, 13550.661233469144, 10949.507272172772, 10988.285761425483, 11237.157213209042, 11397.202195846294, 11420.486078126503, 4413.470383553994, 4453.465584129893, 4523.25366314561, 4582.450105987269, 4684.531546845288, 54791.178132328045, 55969.44030559683, 56182.719086404715, 56238.0, 56540.434595653925, 10689.786204275872, 10769.730756731144, 10898.128149748001, 10907.0, 11008.504617292241, 18972.33596824132, 18978.52553686169, 18991.240350386106, 18998.240070397307, 19002.0, 8158.673653053811, 8305.169483051646, 8422.831543369099, 8655.91344086551, 8686.86969695455, 4853.277051966079, 4885.340479035285, 4952.826651067196, 5000.049990501793, 5002.89994200114, 3452.188735647121, 3455.447128459434, 3457.7233821294235, 3470.774399664014, 3482.89551313461, 598.6647477412663, 599.9070144127667, 608.5192697768713, 609.9298580663192, 614.5698011392044, 750.1410884537174, 751.6241879060469, 757.4886951307845, 776.2625505769541, 778.5762752158145, 9958.751031224278, 9964.402135871871, 10042.297039207186, 10044.29689921713, 10152.0, 608.358182117861, 672.4485921544286, 673.2157037051779, 754.0348354106752, 765.043695380774, 4659.720416775004, 4666.136764698542, 4688.203005489075, 4700.2009658358165, 4746.169420351424, 62481.0, 63593.45626174994, 64147.358526415075, 64493.67753161204, 64669.67665161738, 53850.0, 54867.17699234515, 55190.72404637951, 56284.0, 56917.43082569121, 50591.49408505868, 51424.48575514272, 51592.22611660828, 51778.0, 51870.22194667158, 9206.769830754285, 9255.167034966886, 9314.161725444743, 9346.766330841512, 9354.298427618092, 38401.6159838398, 38983.0, 39273.214535708554, 39810.402843956785, 40158.79920600495, 48457.27314090362, 50415.0, 50463.49536504588, 51055.234171486714, 51277.0, 11260.7747845041, 11282.492287847232, 12632.2420654761, 12659.050571207381, 12955.157914735511, 13709.451621935012, 14169.716605668034, 14193.574192774233, 15008.849911501182, 15665.138417386697, 13174.934125329311, 13223.867761322648, 13237.0, 13734.313284335944, 14018.369173387018, 12781.872181278068, 13662.11196272239, 13788.241646709528, 14627.853721463074, 14629.926850366106, 13548.254845983565, 13593.388297526833, 13741.450341986209, 14585.854141458449, 14591.124532528082, 10165.796684066425, 10363.170946324426, 10392.636257731245, 10506.106980906708, 10595.523201455799, 10799.190060745632, 11211.66365009051, 11226.0, 11233.550657973916, 11322.37726925027], "unit": "score", "name": "yui.html", "value": 6995.830806978362}], "name": "dromaeo_css", "value": 6987.434513618262}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 110.0, 109.0, 98.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 151.0, 166.0, 127.0, 157.0, 165.0, 126.0, 178.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 102.0, 91.0, 75.0, 76.0, 76.0, 107.0, 93.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 92.0, 92.0, 93.0, 145.0, 92.0, 92.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 61.0, 59.0, 60.0, 59.0, 69.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 78.0, 78.0, 78.0, 78.0, 85.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [114.0, 112.0, 112.0, 111.0, 126.0, 112.0, 123.0, 111.0, 120.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [144.0, 137.0, 145.0, 141.0, 140.0, 133.0, 141.0, 142.0, 139.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 65.0, 63.0, 64.0, 66.0, 63.0, 63.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1486.1000000000001}]} 11:39:16 INFO - Return code: 0 11:39:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:39:16 ERROR - # TBPL SUCCESS # 11:39:16 INFO - Running post-action listener: _resource_record_post_action 11:39:16 INFO - Running post-run listener: _resource_record_post_run 11:39:17 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 539238400; Read time: 0; Write time: 628224 11:39:17 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 249040896; Read time: 0; Write time: 386048 11:39:17 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 290193408; Read time: 0; Write time: 242176 11:39:17 INFO - Running post-run listener: _upload_blobber_files 11:39:17 INFO - Blob upload gear active. 11:39:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:39:17 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 11:39:17 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'] 11:39:17 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 11:39:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:18 INFO - (blobuploader) - INFO - Done attempting. 11:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:19 INFO - (blobuploader) - INFO - Done attempting. 11:39:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:19 INFO - Return code: 0 11:39:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:39:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa8dc74c96f7b7bc87728d18282cd765acda741c3772057e50f8e32522ba9c32af502c390d64fbe0b9969838338f88e9bfcc0e29ac5cb18aa46b349b6fd50bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b32b046454c1915eb6cca0cbaef43b4f3ba5ba96a2cf7154f77d5749ddc2202deb4ed1a6f2f6e368891ec78b7d1da1688e41cfe94bed2a9b99871b1c59f2148"} 11:39:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:39:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:39:19 INFO - Contents: 11:39:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa8dc74c96f7b7bc87728d18282cd765acda741c3772057e50f8e32522ba9c32af502c390d64fbe0b9969838338f88e9bfcc0e29ac5cb18aa46b349b6fd50bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b32b046454c1915eb6cca0cbaef43b4f3ba5ba96a2cf7154f77d5749ddc2202deb4ed1a6f2f6e368891ec78b7d1da1688e41cfe94bed2a9b99871b1c59f2148"} 11:39:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:19 INFO - Copying logs to upload dir... 11:39:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:39:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.018000 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-17 11:39:19.196190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 11:39:19.199333) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 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/eaa8dc74c96f7b7bc87728d18282cd765acda741c3772057e50f8e32522ba9c32af502c390d64fbe0b9969838338f88e9bfcc0e29ac5cb18aa46b349b6fd50bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b32b046454c1915eb6cca0cbaef43b4f3ba5ba96a2cf7154f77d5749ddc2202deb4ed1a6f2f6e368891ec78b7d1da1688e41cfe94bed2a9b99871b1c59f2148"} build_url:https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/GuhvNA-XTv-DEcRhOk_Egw/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/eaa8dc74c96f7b7bc87728d18282cd765acda741c3772057e50f8e32522ba9c32af502c390d64fbe0b9969838338f88e9bfcc0e29ac5cb18aa46b349b6fd50bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b32b046454c1915eb6cca0cbaef43b4f3ba5ba96a2cf7154f77d5749ddc2202deb4ed1a6f2f6e368891ec78b7d1da1688e41cfe94bed2a9b99871b1c59f2148"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 11:39:19.223728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:39:19.224055) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458238730.701144-1087622510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:39:19.309874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 11:39:19.310235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 11:39:19.310573) ========= ========= Total master_lag: 0.31 =========