builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1456327486.58 results: success (0) buildid: 20160224043154 builduid: c17384da72ca4cea8311028867616bef revision: d848a5628d801a460a7244cbcdea22d328d8b310 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.579270) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.579699) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.579986) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008665 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.605267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.605541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.619404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.619701) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.668944) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.669237) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.669600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.669867) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 07:24:47-- 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% 76.4M=0s 2016-02-24 07:24:47 (76.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.779271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.779586) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013238 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:46.829111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 07:24:46.829460) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d848a5628d801a460a7244cbcdea22d328d8b310 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d848a5628d801a460a7244cbcdea22d328d8b310 --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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 07:24:47,245 truncating revision to first 12 chars 2016-02-24 07:24:47,245 Setting DEBUG logging. 2016-02-24 07:24:47,245 attempt 1/10 2016-02-24 07:24:47,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d848a5628d80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 07:24:48,274 unpacking tar archive at: mozilla-central-d848a5628d80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 07:24:48.187557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:48.187907) ========= echo d848a5628d801a460a7244cbcdea22d328d8b310 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd848a5628d801a460a7244cbcdea22d328d8b310'] 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d848a5628d801a460a7244cbcdea22d328d8b310 program finished with exit code 0 elapsedTime=0.003809 script_repo_revision: 'd848a5628d801a460a7244cbcdea22d328d8b310' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:48.235822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:48.236119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 07:24:48.245592) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-24 07:24:48.245856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:48 INFO - MultiFileLogger online at 20160224 07:24:48 in /builds/slave/test-pgo 07:24:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:24:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:24:48 INFO - {'append_to_log': False, 07:24:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:24:48 INFO - 'blob_upload_branch': 'Firefox', 07:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:24:48 INFO - 'branch': 'Firefox', 07:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:48 INFO - 'config_files': ('talos/linux_config.py',), 07:24:48 INFO - 'default_actions': ('clobber', 07:24:48 INFO - 'read-buildbot-config', 07:24:48 INFO - 'download-and-extract', 07:24:48 INFO - 'populate-webroot', 07:24:48 INFO - 'create-virtualenv', 07:24:48 INFO - 'install', 07:24:48 INFO - 'run-tests'), 07:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:48 INFO - 'download_minidump_stackwalk': True, 07:24:48 INFO - 'download_symbols': 'ondemand', 07:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:48 INFO - 'installer_path': 'installer.exe', 07:24:48 INFO - 'log_level': 'info', 07:24:48 INFO - 'log_name': 'talos', 07:24:48 INFO - 'log_to_console': True, 07:24:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:48 INFO - 'opt_config_files': (), 07:24:48 INFO - 'pip_index': False, 07:24:48 INFO - 'sps_profile': False, 07:24:48 INFO - 'sps_profile_interval': 0, 07:24:48 INFO - 'suite': 'dromaeojs', 07:24:48 INFO - 'system_bits': '32', 07:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:48 INFO - 'title': 'talos-linux64-ix-028', 07:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:48 INFO - 'use_talos_json': True, 07:24:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:48 INFO - 'work_dir': 'build'} 07:24:48 INFO - ##### 07:24:48 INFO - ##### Running clobber step. 07:24:48 INFO - ##### 07:24:48 INFO - Running pre-action listener: _resource_record_pre_action 07:24:48 INFO - Running main action method: clobber 07:24:48 INFO - rmtree: /builds/slave/test-pgo/build 07:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:24:49 INFO - Running post-action listener: _resource_record_post_action 07:24:49 INFO - ##### 07:24:49 INFO - ##### Running read-buildbot-config step. 07:24:49 INFO - ##### 07:24:49 INFO - Running pre-action listener: _resource_record_pre_action 07:24:49 INFO - Running main action method: read_buildbot_config 07:24:49 INFO - Using buildbot properties: 07:24:49 INFO - { 07:24:49 INFO - "project": "", 07:24:49 INFO - "product": "firefox", 07:24:49 INFO - "script_repo_revision": "production", 07:24:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:24:49 INFO - "repository": "", 07:24:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:24:49 INFO - "buildid": "20160224043154", 07:24:49 INFO - "pgo_build": "True", 07:24:49 INFO - "basedir": "/builds/slave/test-pgo", 07:24:49 INFO - "buildnumber": 205, 07:24:49 INFO - "slavename": "talos-linux64-ix-028", 07:24:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:24:49 INFO - "platform": "ubuntu64_hw", 07:24:49 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:24:49 INFO - "branch": "mozilla-central", 07:24:49 INFO - "repo_path": "mozilla-central", 07:24:49 INFO - "revision": "d848a5628d801a460a7244cbcdea22d328d8b310", 07:24:49 INFO - "stage_platform": "linux64-pgo", 07:24:49 INFO - "builduid": "c17384da72ca4cea8311028867616bef", 07:24:49 INFO - "slavebuilddir": "test" 07:24:49 INFO - } 07:24:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 07:24:49 INFO - Running post-action listener: _resource_record_post_action 07:24:49 INFO - ##### 07:24:49 INFO - ##### Running download-and-extract step. 07:24:49 INFO - ##### 07:24:49 INFO - Running pre-action listener: _resource_record_pre_action 07:24:49 INFO - Running main action method: download_and_extract 07:24:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:24:49 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')]} 07:24:49 INFO - https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/test_packages.json 07:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/test_packages.json 07:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:24:50 INFO - Downloaded 1448 bytes. 07:24:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:24:50 INFO - Using the following test package requirements: 07:24:50 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:50 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:24:50 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:24:50 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'jsshell-linux-x86_64.zip'], 07:24:50 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:24:50 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:50 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:24:50 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:24:50 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:24:50 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:50 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:50 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:24:50 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:50 INFO - https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:24:51 INFO - Downloaded 23367919 bytes. 07:24:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:24:52 INFO - Return code: 0 07:24:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:24:52 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')]} 07:24:52 INFO - https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:24:54 INFO - Downloaded 23367919 bytes. 07:24:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:24:55 INFO - Return code: 0 07:24:55 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')]} 07:24:55 INFO - https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:24:56 INFO - Downloaded 10707015 bytes. 07:24:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:24:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:24:56 INFO - Return code: 0 07:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:56 INFO - https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:24:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:24:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:24:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:24:58 INFO - Downloaded 56656083 bytes. 07:24:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:24:58 INFO - mkdir: /builds/slave/test-pgo/properties 07:24:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:24:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:24:58 INFO - Contents: 07:24:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:24:59 INFO - Running post-action listener: _resource_record_post_action 07:24:59 INFO - Running post-action listener: set_extra_try_arguments 07:24:59 INFO - ##### 07:24:59 INFO - ##### Running populate-webroot step. 07:24:59 INFO - ##### 07:24:59 INFO - Running pre-action listener: _resource_record_pre_action 07:24:59 INFO - Running main action method: populate_webroot 07:24:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:59 INFO - '--tppagecycles', 07:24:59 INFO - '7'], 07:24:59 INFO - 'tests': ['tsvgm']}}, 07:24:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:24:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:24:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'tests': ['damp', 'tps']}, 07:24:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['damp', 'tps']}, 07:24:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:24:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:59 INFO - 'other': {'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'other_l64': {'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'other_nol64': {'tests': ['a11yr', 07:24:59 INFO - 'ts_paint', 07:24:59 INFO - 'tpaint', 07:24:59 INFO - 'sessionrestore', 07:24:59 INFO - 'sessionrestore_no_auto_restore']}, 07:24:59 INFO - 'svgr': {'tests': ['tsvgx', 07:24:59 INFO - 'tsvgr_opacity', 07:24:59 INFO - 'tart', 07:24:59 INFO - 'tscrollx', 07:24:59 INFO - 'cart']}, 07:24:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['tsvgx', 07:24:59 INFO - 'tsvgr_opacity', 07:24:59 INFO - 'tart', 07:24:59 INFO - 'tscrollx', 07:24:59 INFO - 'cart']}, 07:24:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'tests': ['tp5o']}, 07:24:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'talos_options': ['--e10s'], 07:24:59 INFO - 'tests': ['tp5o']}, 07:24:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'talos_options': ['--xperf_path', 07:24:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:59 INFO - 'tests': ['tp5n']}, 07:24:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:59 INFO - 'talos_options': ['--e10s', 07:24:59 INFO - '--xperf_path', 07:24:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:59 INFO - 'tests': ['tp5n']}}, 07:24:59 INFO - 'talos.zip': {'path': '', 07:24:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:59 INFO - Running post-action listener: _resource_record_post_action 07:24:59 INFO - ##### 07:24:59 INFO - ##### Running create-virtualenv step. 07:24:59 INFO - ##### 07:24:59 INFO - Running pre-action listener: _resource_record_pre_action 07:24:59 INFO - Running main action method: create_virtualenv 07:24:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:24:59 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 07:24:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:24:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:59 INFO - Using real prefix '/usr' 07:24:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:24:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:01 INFO - Installing pip.................done. 07:25:01 INFO - Return code: 0 07:25:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:25: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')]} 07:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:25:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:25:01 INFO - Using env: {'DISPLAY': ':0', 07:25:01 INFO - 'HOME': '/home/cltbld', 07:25:01 INFO - 'LANG': 'en_US.UTF-8', 07:25:01 INFO - 'LANGUAGE': 'en_US:en', 07:25:01 INFO - 'LOGNAME': 'cltbld', 07:25:01 INFO - 'MAIL': '/var/mail/cltbld', 07:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:01 INFO - 'MOZ_NO_REMOTE': '1', 07:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:01 INFO - 'NO_EM_RESTART': '1', 07:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:01 INFO - 'SHELL': '/bin/bash', 07:25:01 INFO - 'SHLVL': '1', 07:25:01 INFO - 'TERM': 'linux', 07:25:01 INFO - 'TMOUT': '86400', 07:25:01 INFO - 'USER': 'cltbld', 07:25:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:01 INFO - '_': '/tools/buildbot/bin/python'} 07:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:01 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 07:25:01 INFO - Cleaning up... 07:25:01 INFO - Return code: 0 07:25:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:25: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')]} 07:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:25:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:25:01 INFO - Using env: {'DISPLAY': ':0', 07:25:01 INFO - 'HOME': '/home/cltbld', 07:25:01 INFO - 'LANG': 'en_US.UTF-8', 07:25:01 INFO - 'LANGUAGE': 'en_US:en', 07:25:01 INFO - 'LOGNAME': 'cltbld', 07:25:01 INFO - 'MAIL': '/var/mail/cltbld', 07:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:01 INFO - 'MOZ_NO_REMOTE': '1', 07:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:01 INFO - 'NO_EM_RESTART': '1', 07:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:01 INFO - 'SHELL': '/bin/bash', 07:25:01 INFO - 'SHLVL': '1', 07:25:01 INFO - 'TERM': 'linux', 07:25:01 INFO - 'TMOUT': '86400', 07:25:01 INFO - 'USER': 'cltbld', 07:25:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:01 INFO - '_': '/tools/buildbot/bin/python'} 07:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:02 INFO - Downloading/unpacking psutil>=0.7.1 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:04 INFO - Installing collected packages: psutil 07:25:04 INFO - Running setup.py install for psutil 07:25:04 INFO - building 'psutil._psutil_linux' extension 07:25:04 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 07:25:04 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 07:25:04 INFO - building 'psutil._psutil_posix' extension 07:25:04 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 07:25:04 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 07:25:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:04 INFO - Successfully installed psutil 07:25:04 INFO - Cleaning up... 07:25:04 INFO - Return code: 0 07:25:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:25:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:25:04 INFO - Using env: {'DISPLAY': ':0', 07:25:04 INFO - 'HOME': '/home/cltbld', 07:25:04 INFO - 'LANG': 'en_US.UTF-8', 07:25:04 INFO - 'LANGUAGE': 'en_US:en', 07:25:04 INFO - 'LOGNAME': 'cltbld', 07:25:04 INFO - 'MAIL': '/var/mail/cltbld', 07:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:04 INFO - 'MOZ_NO_REMOTE': '1', 07:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:04 INFO - 'NO_EM_RESTART': '1', 07:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:04 INFO - 'SHELL': '/bin/bash', 07:25:04 INFO - 'SHLVL': '1', 07:25:04 INFO - 'TERM': 'linux', 07:25:04 INFO - 'TMOUT': '86400', 07:25:04 INFO - 'USER': 'cltbld', 07:25:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:04 INFO - '_': '/tools/buildbot/bin/python'} 07:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:25:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:25:06 INFO - Installing collected packages: mozsystemmonitor 07:25:06 INFO - Running setup.py install for mozsystemmonitor 07:25:06 INFO - Successfully installed mozsystemmonitor 07:25:06 INFO - Cleaning up... 07:25:06 INFO - Return code: 0 07:25:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:25: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')]} 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', '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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:25: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 blobuploader==1.2.4 07:25:06 INFO - Using env: {'DISPLAY': ':0', 07:25:06 INFO - 'HOME': '/home/cltbld', 07:25:06 INFO - 'LANG': 'en_US.UTF-8', 07:25:06 INFO - 'LANGUAGE': 'en_US:en', 07:25:06 INFO - 'LOGNAME': 'cltbld', 07:25:06 INFO - 'MAIL': '/var/mail/cltbld', 07:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:06 INFO - 'MOZ_NO_REMOTE': '1', 07:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:06 INFO - 'NO_EM_RESTART': '1', 07:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:06 INFO - 'SHELL': '/bin/bash', 07:25:06 INFO - 'SHLVL': '1', 07:25:06 INFO - 'TERM': 'linux', 07:25:06 INFO - 'TMOUT': '86400', 07:25:06 INFO - 'USER': 'cltbld', 07:25:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:06 INFO - '_': '/tools/buildbot/bin/python'} 07:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:07 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 07:25:07 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 07:25:07 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 07:25:07 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 07:25:07 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 07:25:07 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 07:25:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:08 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 07:25:08 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 07:25:08 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 07:25:08 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 07:25:08 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 07:25:08 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 07:25:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:25:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:09 INFO - Downloading docopt-0.6.1.tar.gz 07:25:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:09 INFO - Running setup.py install for blobuploader 07:25:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:25:09 INFO - Running setup.py install for requests 07:25:10 INFO - Running setup.py install for docopt 07:25:10 INFO - Successfully installed blobuploader requests docopt 07:25:10 INFO - Cleaning up... 07:25:10 INFO - Return code: 0 07:25:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:10 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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:10 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 07:25:10 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 07:25:10 INFO - Using env: {'DISPLAY': ':0', 07:25:10 INFO - 'HOME': '/home/cltbld', 07:25:10 INFO - 'LANG': 'en_US.UTF-8', 07:25:10 INFO - 'LANGUAGE': 'en_US:en', 07:25:10 INFO - 'LOGNAME': 'cltbld', 07:25:10 INFO - 'MAIL': '/var/mail/cltbld', 07:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:10 INFO - 'MOZ_NO_REMOTE': '1', 07:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:10 INFO - 'NO_EM_RESTART': '1', 07:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:10 INFO - 'SHELL': '/bin/bash', 07:25:10 INFO - 'SHLVL': '1', 07:25:10 INFO - 'TERM': 'linux', 07:25:10 INFO - 'TMOUT': '86400', 07:25:10 INFO - 'USER': 'cltbld', 07:25:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:10 INFO - '_': '/tools/buildbot/bin/python'} 07:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:25:10 INFO - Running setup.py (path:/tmp/pip-ZJWtWI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:25:10 INFO - Running setup.py (path:/tmp/pip-hOvXkR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:25:10 INFO - Running setup.py (path:/tmp/pip-s88LGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:25:10 INFO - Running setup.py (path:/tmp/pip-1YcQXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:25:10 INFO - Running setup.py (path:/tmp/pip-TBC8Y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:25:10 INFO - Running setup.py (path:/tmp/pip-05kxFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:25:10 INFO - Running setup.py (path:/tmp/pip-Dxj0uZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:25:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:25:10 INFO - Running setup.py (path:/tmp/pip-RqOFMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:25:11 INFO - Running setup.py (path:/tmp/pip-qZOIIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:25:11 INFO - Running setup.py (path:/tmp/pip-oTgzlZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:25:11 INFO - Running setup.py (path:/tmp/pip-jgOsH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:25:11 INFO - Running setup.py (path:/tmp/pip-u8r3_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:25:11 INFO - Running setup.py (path:/tmp/pip-uMONKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:25:11 INFO - Running setup.py (path:/tmp/pip-O7VkRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:25:11 INFO - Running setup.py (path:/tmp/pip-dLVu5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:25:11 INFO - Running setup.py (path:/tmp/pip-rg8Tr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:25:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:25:11 INFO - Running setup.py (path:/tmp/pip-sh_yja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:25:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:11 INFO - Running setup.py install for manifestparser 07:25:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:25:11 INFO - Running setup.py install for mozcrash 07:25:11 INFO - Running setup.py install for mozdebug 07:25:12 INFO - Running setup.py install for mozdevice 07:25:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for mozfile 07:25:12 INFO - Running setup.py install for mozhttpd 07:25:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for mozinfo 07:25:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for mozInstall 07:25:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for mozleak 07:25:12 INFO - Running setup.py install for mozlog 07:25:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for moznetwork 07:25:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:25:12 INFO - Running setup.py install for mozprocess 07:25:12 INFO - Running setup.py install for mozprofile 07:25:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:25:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:25:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:25:13 INFO - Running setup.py install for mozrunner 07:25:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:25:13 INFO - Running setup.py install for mozscreenshot 07:25:13 INFO - Running setup.py install for moztest 07:25:13 INFO - Running setup.py install for mozversion 07:25:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:25:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:13 INFO - Cleaning up... 07:25:13 INFO - Return code: 0 07:25:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:13 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 07:25:13 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 07:25:13 INFO - Using env: {'DISPLAY': ':0', 07:25:13 INFO - 'HOME': '/home/cltbld', 07:25:13 INFO - 'LANG': 'en_US.UTF-8', 07:25:13 INFO - 'LANGUAGE': 'en_US:en', 07:25:13 INFO - 'LOGNAME': 'cltbld', 07:25:13 INFO - 'MAIL': '/var/mail/cltbld', 07:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:13 INFO - 'MOZ_NO_REMOTE': '1', 07:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:13 INFO - 'NO_EM_RESTART': '1', 07:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:13 INFO - 'SHELL': '/bin/bash', 07:25:13 INFO - 'SHLVL': '1', 07:25:13 INFO - 'TERM': 'linux', 07:25:13 INFO - 'TMOUT': '86400', 07:25:13 INFO - 'USER': 'cltbld', 07:25:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:13 INFO - '_': '/tools/buildbot/bin/python'} 07:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:25:13 INFO - Running setup.py (path:/tmp/pip-lURSYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:25:13 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)) 07:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:25:13 INFO - Running setup.py (path:/tmp/pip-HtkA2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:25:13 INFO - Running setup.py (path:/tmp/pip-xwROEm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:25:13 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)) 07:25:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:25:13 INFO - Running setup.py (path:/tmp/pip-l1ZkuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:25:14 INFO - Running setup.py (path:/tmp/pip-eW3aDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:25:14 INFO - Running setup.py (path:/tmp/pip-CrtFnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:25:14 INFO - Running setup.py (path:/tmp/pip-dyZESk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:25:14 INFO - Running setup.py (path:/tmp/pip-Ct5K1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:25:14 INFO - Running setup.py (path:/tmp/pip-sVNCD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:25:14 INFO - Running setup.py (path:/tmp/pip-g6STS8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:25:14 INFO - Running setup.py (path:/tmp/pip-7TKmAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:25:14 INFO - Running setup.py (path:/tmp/pip-bvLJK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:25:14 INFO - Running setup.py (path:/tmp/pip-34DDb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:25:14 INFO - Running setup.py (path:/tmp/pip-8PCifZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:25:14 INFO - Running setup.py (path:/tmp/pip-0WfacR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:25:14 INFO - Running setup.py (path:/tmp/pip-086TBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:25:14 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)) 07:25:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:25:14 INFO - Running setup.py (path:/tmp/pip-4KhHb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:25:14 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)) 07:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:25:14 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)) 07:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:25:14 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)) 07:25:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:16 INFO - Downloading blessings-1.6.tar.gz 07:25:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:16 INFO - Installing collected packages: blessings 07:25:16 INFO - Running setup.py install for blessings 07:25:16 INFO - Successfully installed blessings 07:25:16 INFO - Cleaning up... 07:25:16 INFO - Return code: 0 07:25:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:25:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:25:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:25:17 INFO - Reading from file tmpfile_stdout 07:25:17 INFO - Current package versions: 07:25:17 INFO - argparse == 1.2.1 07:25:17 INFO - blessings == 1.6 07:25:17 INFO - blobuploader == 1.2.4 07:25:17 INFO - docopt == 0.6.1 07:25:17 INFO - manifestparser == 1.1 07:25:17 INFO - mozInstall == 1.12 07:25:17 INFO - mozcrash == 0.16 07:25:17 INFO - mozdebug == 0.1 07:25:17 INFO - mozdevice == 0.48 07:25:17 INFO - mozfile == 1.2 07:25:17 INFO - mozhttpd == 0.7 07:25:17 INFO - mozinfo == 0.9 07:25:17 INFO - mozleak == 0.1 07:25:17 INFO - mozlog == 3.1 07:25:17 INFO - moznetwork == 0.27 07:25:17 INFO - mozprocess == 0.22 07:25:17 INFO - mozprofile == 0.28 07:25:17 INFO - mozrunner == 6.11 07:25:17 INFO - mozscreenshot == 0.1 07:25:17 INFO - mozsystemmonitor == 0.0 07:25:17 INFO - moztest == 0.7 07:25:17 INFO - mozversion == 1.4 07:25:17 INFO - psutil == 3.1.1 07:25:17 INFO - requests == 1.2.3 07:25:17 INFO - wsgiref == 0.1.2 07:25:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:17 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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:17 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 07:25:17 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 07:25:17 INFO - Using env: {'DISPLAY': ':0', 07:25:17 INFO - 'HOME': '/home/cltbld', 07:25:17 INFO - 'LANG': 'en_US.UTF-8', 07:25:17 INFO - 'LANGUAGE': 'en_US:en', 07:25:17 INFO - 'LOGNAME': 'cltbld', 07:25:17 INFO - 'MAIL': '/var/mail/cltbld', 07:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:17 INFO - 'MOZ_NO_REMOTE': '1', 07:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:17 INFO - 'NO_EM_RESTART': '1', 07:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:17 INFO - 'SHELL': '/bin/bash', 07:25:17 INFO - 'SHLVL': '1', 07:25:17 INFO - 'TERM': 'linux', 07:25:17 INFO - 'TMOUT': '86400', 07:25:17 INFO - 'USER': 'cltbld', 07:25:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:17 INFO - '_': '/tools/buildbot/bin/python'} 07:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 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)) 07:25:17 INFO - Cleaning up... 07:25:17 INFO - Return code: 0 07:25:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:25:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:17 INFO - Using env: {'DISPLAY': ':0', 07:25:17 INFO - 'HOME': '/home/cltbld', 07:25:17 INFO - 'LANG': 'en_US.UTF-8', 07:25:17 INFO - 'LANGUAGE': 'en_US:en', 07:25:17 INFO - 'LOGNAME': 'cltbld', 07:25:17 INFO - 'MAIL': '/var/mail/cltbld', 07:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:17 INFO - 'MOZ_NO_REMOTE': '1', 07:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:17 INFO - 'NO_EM_RESTART': '1', 07:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:17 INFO - 'SHELL': '/bin/bash', 07:25:17 INFO - 'SHLVL': '1', 07:25:17 INFO - 'TERM': 'linux', 07:25:17 INFO - 'TMOUT': '86400', 07:25:17 INFO - 'USER': 'cltbld', 07:25:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:17 INFO - '_': '/tools/buildbot/bin/python'} 07:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:17 INFO - Downloading/unpacking jsonschema 07:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:19 INFO - warning: no files found matching '*.txt' 07:25:19 INFO - no previously-included directories found matching 'build' 07:25:19 INFO - no previously-included directories found matching 'dist' 07:25:19 INFO - no previously-included directories found matching '.git*' 07:25:19 INFO - Installing collected packages: jsonschema, functools32 07:25:19 INFO - Running setup.py install for functools32 07:25:19 INFO - warning: no files found matching '*.txt' 07:25:19 INFO - no previously-included directories found matching 'build' 07:25:19 INFO - no previously-included directories found matching 'dist' 07:25:19 INFO - no previously-included directories found matching '.git*' 07:25:19 INFO - Successfully installed jsonschema functools32 07:25:19 INFO - Cleaning up... 07:25:19 INFO - Return code: 0 07:25:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:25:19 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')]} 07:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 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')]} 07:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 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 0x7fa7140dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2731670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, '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': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', '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 07:25:19 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 07:25:19 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 07:25:19 INFO - Using env: {'DISPLAY': ':0', 07:25:19 INFO - 'HOME': '/home/cltbld', 07:25:19 INFO - 'LANG': 'en_US.UTF-8', 07:25:19 INFO - 'LANGUAGE': 'en_US:en', 07:25:19 INFO - 'LOGNAME': 'cltbld', 07:25:19 INFO - 'MAIL': '/var/mail/cltbld', 07:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:19 INFO - 'MOZ_NO_REMOTE': '1', 07:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:19 INFO - 'NO_EM_RESTART': '1', 07:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:19 INFO - 'SHELL': '/bin/bash', 07:25:19 INFO - 'SHLVL': '1', 07:25:19 INFO - 'TERM': 'linux', 07:25:19 INFO - 'TMOUT': '86400', 07:25:19 INFO - 'USER': 'cltbld', 07:25:19 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:19 INFO - '_': '/tools/buildbot/bin/python'} 07:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:20 INFO - Downloading/unpacking flake8 07:25:20 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 07:25:20 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 07:25:20 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 07:25:20 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 07:25:20 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 07:25:20 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 07:25:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:25:21 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 07:25:21 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 07:25:21 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 07:25:21 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 07:25:21 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 07:25:21 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 07:25:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:22 INFO - no previously-included directories found matching 'docs/_build' 07:25:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:22 INFO - Running setup.py install for pep8 07:25:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:22 INFO - no previously-included directories found matching 'docs/_build' 07:25:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:25:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:22 INFO - Cleaning up... 07:25:22 INFO - Return code: 0 07:25:22 INFO - Running post-action listener: _resource_record_post_action 07:25:22 INFO - Running post-action listener: _start_resource_monitoring 07:25:22 INFO - Starting resource monitoring. 07:25:22 INFO - ##### 07:25:22 INFO - ##### Running install step. 07:25:22 INFO - ##### 07:25:22 INFO - Running pre-action listener: _resource_record_pre_action 07:25:22 INFO - Running main action method: install 07:25:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:25:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:25:23 INFO - Reading from file tmpfile_stdout 07:25:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:25:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:25:23 INFO - Reading from file tmpfile_stdout 07:25:23 INFO - Output received: 07:25:23 INFO - Usage: mozinstall [options] installer 07:25:23 INFO - Options: 07:25:23 INFO - -h, --help show this help message and exit 07:25:23 INFO - -d DEST, --destination=DEST 07:25:23 INFO - Directory to install application into. [default: 07:25:23 INFO - "/builds/slave/test-pgo"] 07:25:23 INFO - --app=APP Application being installed. [default: firefox] 07:25:23 INFO - mkdir: /builds/slave/test-pgo/build/application 07:25:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:25:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:25:39 INFO - Reading from file tmpfile_stdout 07:25:39 INFO - Output received: 07:25:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:25:39 INFO - Running post-action listener: _resource_record_post_action 07:25:39 INFO - ##### 07:25:39 INFO - ##### Running run-tests step. 07:25:39 INFO - ##### 07:25:39 INFO - Running pre-action listener: _resource_record_pre_action 07:25:39 INFO - Running main action method: run_tests 07:25:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:25:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:25:39 INFO - Python 2.7.3 07:25:39 INFO - Return code: 0 07:25:39 INFO - grabbing minidump binary from tooltool 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 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 0x27c08c0>, '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 0x27c17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c1c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:25:39 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 07:25:39 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 07:25:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:39 INFO - Return code: 0 07:25:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:25:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:25:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:25:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:25:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:25:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:25:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:25:40 INFO - Return code: 0 07:25:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:25:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 07:25:40 INFO - Using env: {'DISPLAY': ':0', 07:25:40 INFO - 'HOME': '/home/cltbld', 07:25:40 INFO - 'LANG': 'en_US.UTF-8', 07:25:40 INFO - 'LANGUAGE': 'en_US:en', 07:25:40 INFO - 'LOGNAME': 'cltbld', 07:25:40 INFO - 'MAIL': '/var/mail/cltbld', 07:25:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:25:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:40 INFO - 'MOZ_NO_REMOTE': '1', 07:25:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:40 INFO - 'NO_EM_RESTART': '1', 07:25:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:25:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:25:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:25:40 INFO - 'SHELL': '/bin/bash', 07:25:40 INFO - 'SHLVL': '1', 07:25:40 INFO - 'TERM': 'linux', 07:25:40 INFO - 'TMOUT': '86400', 07:25:40 INFO - 'USER': 'cltbld', 07:25:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069', 07:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:40 INFO - '_': '/tools/buildbot/bin/python'} 07:25:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:25:40 INFO - mozversion application_buildid: 20160224043154 07:25:40 INFO - mozversion application_changeset: d848a5628d801a460a7244cbcdea22d328d8b310 07:25:40 INFO - mozversion application_display_name: Nightly 07:25:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:40 INFO - mozversion application_name: Firefox 07:25:40 INFO - mozversion application_remotingname: firefox 07:25:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:25:40 INFO - mozversion application_vendor: Mozilla 07:25:40 INFO - mozversion application_version: 47.0a1 07:25:40 INFO - mozversion platform_buildid: 20160224043154 07:25:40 INFO - mozversion platform_changeset: d848a5628d801a460a7244cbcdea22d328d8b310 07:25:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:25:40 INFO - mozversion platform_version: 47.0a1 07:25:40 INFO - using testdate: 1456327540 07:25:40 INFO - actual date: 1456327540 07:25:40 INFO - starting webserver on 'localhost:48267' 07:25:40 INFO - SUITE-START | Running 2 tests 07:25:40 INFO - TEST-START | dromaeo_css 07:25:40 INFO - operating with platform_type : linux_ 07:25:40 INFO - Initialising browser for dromaeo_css test... 07:25:40 INFO - TEST-INFO | started process 31427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZni6Xj/profile http://localhost:48267/getInfo.html) 07:25:45 INFO - PROCESS | 31427 | __metrics Screen width/height:1600/1200 07:25:45 INFO - PROCESS | 31427 | colorDepth:24 07:25:45 INFO - PROCESS | 31427 | Browser inner width/height: 1024/697 07:25:45 INFO - PROCESS | 31427 | __metrics 07:25:46 INFO - PROCESS | 31427 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:47 INFO - TEST-INFO | 31427: exit 0 07:25:47 INFO - Browser initialized. 07:25:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:47 INFO - TEST-INFO | started process 31526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZni6Xj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:59 INFO - PROCESS | 31526 | RSS: Main: 147533824 07:25:59 INFO - PROCESS | 31526 | 07:26:50 INFO - PROCESS | 31526 | 1456327610077 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] 07:28:59 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48267/tests/dromaeo/cssquery-ext.html) 07:29:00 INFO - PROCESS | 31526 | RSS: Main: 266870784 07:29:00 INFO - PROCESS | 31526 | 07:32:02 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-ext.html (next: http://localhost:48267/tests/dromaeo/cssquery-jquery.html) 07:32:03 INFO - PROCESS | 31526 | RSS: Main: 243359744 07:32:03 INFO - PROCESS | 31526 | 07:35:05 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48267/tests/dromaeo/cssquery-mootools.html) 07:35:06 INFO - PROCESS | 31526 | RSS: Main: 243933184 07:35:06 INFO - PROCESS | 31526 | 07:38:07 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48267/tests/dromaeo/cssquery-prototype.html) 07:38:08 INFO - PROCESS | 31526 | RSS: Main: 219840512 07:38:08 INFO - PROCESS | 31526 | 07:41:11 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48267/tests/dromaeo/cssquery-yui.html) 07:41:11 INFO - PROCESS | 31526 | RSS: Main: 190492672 07:41:11 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | Cycle 1(1): loaded http://localhost:48267/tests/dromaeo/cssquery-yui.html (next: http://localhost:48267/tests/dromaeo/cssquery-dojo.html) 07:44:14 INFO - PROCESS | 31526 | RSS: Main: 466440192 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | __start_tp_report 07:44:14 INFO - PROCESS | 31526 | _x_x_mozilla_page_load 07:44:14 INFO - PROCESS | 31526 | _x_x_mozilla_page_load_details 07:44:14 INFO - PROCESS | 31526 | |i|pagename|runs| 07:44:14 INFO - PROCESS | 31526 | |0;dojo.html;3146.826924519152;3196.984015079924;3222.146131275211;3225.242068113993;3273.165342837576;5133.050385678652;5186.455422180668;5188.403333616626;5211.3225280713505;5244.396894357145;5212.556932660719;5246.606504512168;5272;5281.841544753664;5300.973495132529;4769.833055843046;4796.52034796521;4811.326414302001;4816.3016362627395;4944.283078953567;4846.830360937368;4858.5627293543575;4885.267209918523;4911.287863259825;4935.111679897617;4714.90570188596;4738.241881298975;4803.18345881201;4807.4471435784635;4820.108279968217;4726;4732.1718699227495;4736.147493451177;4759.309900064472;4764.309175169616;4674.602658774008;4715.834945776881;4728.66899317048;4755.548222918817;4772.785224664898;5064.594832413398;5076.111680455905;5086.79652813887;5089.3638295213095;5116.411612664554;5597.3003374578175;5599.832005039855;5600.271964644611;5613.578981576398;5634.267545219136;5554.416786237468;5678.943210567924;5699.2306038684665;5723.799667011676;5753.33836608787;5250.8687282817855;5253.343332083489;5254.106801843695;5258.789648414059;5270.077736396115;5557.083081291542;5728.1407788831175;5728.369879313273;5736.282964629421;5741.799037033684;5525.668459892419;5563.054280772279;5577.358603760619;5587.972060139755;5638.577106717013;5568.582356323292;5615.326160860723;5619.578531610064;5621.522170615462;5626;5505.174223866452;5585.804496842591;5596.3284405870745;5602.887942241132;5698.373178950312;5530.446955304437;5542.722863856871;5549.667019978814;5551;5561.916571251434;4310.396544483775;4324.437823083042;4332.1119170569955;4358.498772641124;4369.737815731066;3843.0392401899526;3885.048163200034;3923.9803800980812;3936.0159960009996;3938.212357528506;5255.08036093682;5270.657407268592;5277.498637629419;5278.874580844879;5295.205719142159;5600.27196464457;5609.635373700697;5610.410906854721;5611.466910643482;5616.606837521416;5136.897262054738;5139.331886854759;5164.690118592896;5197.7401129943355;5232.319798426181;4778.880527986758;4809.495003024632;4816.181249187646;4817.0606731686985;4858.514148585184;5797.36229014808;5850.0932355484965;5868.119782032644;5868.295804503487;5877.294724633071;5577.8047768327915;5593.07714227148;5594.748236329294;5607.41122182165;5632.32412110533;5844.503217226414;5874.853128671817;5878.353381127987;5878.412158784087;5881.911771323348;5405.135178371442;5533.446655334435;5541.445855414427;5584.553235741049;5639.379668236409;5600.299962504687;5608.355039170385;5637.57718171147;5641.323041235078;5643.068893632669;5409.7024663642305;5462.945370546244;5479.2602998594675;5483.561315094703;5528.281323427928;5392.865178370572;5453.536449401845;5486.698231597141;5491.093969494988;5505.476979686923;5379.515843574097;5395.487428694268;5397.514223719884;5404.8108316208745;5410.945890541044;5428.91856622143;5499.3675727291875;5510.173473978935;5523.613347065667;5562.276904002454;5295;5297.046531624344;5322.787088516416;5366.195070739421;5389.164679474688 07:44:14 INFO - PROCESS | 31526 | |1;ext.html;532.7043490862571;533.3945971322551;540.8107162493128;553.5405613340929;555.0176188146983;28390.29024274394;37170.8141459293;37445.81277093617;37496;37524.24951500972;40412.79793601035;40860.18279634405;40862;40903;40979.385309220386;8371.414001019946;8542.829143417128;8597.140285971383;8608.440451370672;8612.612432440555;8431.072582015973;8549.871751923725;8569.742907712778;8572.671235958436;8576.485410875337;8537.445066070717;8890.511021893793;8890.955545222265;8891.555422228896;8913.15325044123;8738;8827.205551500363;8836.602352894135;8840.071792461764;8845;8471.83056338876;8569;8604.139586041409;8618;8621.094785047542;39829;40167;40184.59815401838;40222.396664050066;40249.396259056135;3403.8638454461793;3724.2923844469465;3966.920661586781;4016.49793775778;4046.2514434829354;29810.485060263705;30183.69816301853;30226.244343891358;30954.226144346347;31056.378872422425;3701.9444708329397;3722.1253005543676;3738.1776009277914;3748.5689145748042;3829.5787463379006;256090;257340;257942;258336;258648;51564;58246.30167530703;58908.410915890294;59061.40938590645;59078;59578.40421595815;59679.70160149258;59760.40239597635;59835.700821495615;60014;12492.75014499705;13381.799273010913;13405.731885362238;13472.5284615038;14969.476068337555;10712;10778.29941053829;10779.353238805697;10789.40658263803;10790.406527641055;19018.42944711661;19118.139683714267;19164.520886977938;19791.901040494704;19841.503962400766;7167.749128780468;7307.890381644173;7376.225496322809;7406.518576292524;7466.813329666802;910.7632015675839;988.678679429174;1069.4064794039382;1078.6386560502162;1094.9124070074374;24448.633270500955;24552.5089498209;24670.13654522119;24808.37979050502;24861;968.6658102954469;1051.2168434516334;1053.599632139782;1183.47335435732;1186.590626233948;13350.46598136083;13407.731845363038;13626.863731362757;14045.648858778612;14241.50154744579;295521;297947;299212;299653;299875.50186747214;52279.73860130675;52755.73622131865;53054.73472632612;53076.46923530715;53257;1262.3309645887693;1273.7134144817342;1283.557172775391;1331.8668133186604;1339.1563315111418;24931.62602560927;26180.08369707051;26466.073687421616;26647.7335226653;26660.466790664464;42584.361234582124;44065.559344406145;44377;44378.77810610926;44546.77726611346;180684;276486;282674;282751;282962;28791.712082878905;29354.706452935196;29518.704812951597;29623.555646665747;29670.258243544085;39123;39630.80184599059;40315.395269071574;40526.59473405228;40684.79657601693;30365.392692146474;31337.8433107833;31367;31936.840315799203;32160.35679286448;36209;36565.81717091398;36910;36930;37574.624253757116;35918;36570.45144322891;37156.814215928745;37158.25683486369;37183;27659.308517287227;28065.158045258675;29775.255618609706;31947.520787187746;32065.358692826478;23894.402639934142;23902.641460378458;23978.40053998664;24186.75813241845;24243.636345455187 07:44:14 INFO - PROCESS | 31526 | |2;jquery.html;361.9330423871583;362.4110819917634;364.0679859559526;370.80532720321827;371.0667670807917;13872.861271387283;16812.66374672506;17031.82968170318;17171.399001034966;17956.55108622285;16313.83686163138;16597.751033734505;16804.411845585408;16833.41083062093;16867.83132168678;5210.973945130269;5291.708956007418;5374.758135883875;5394.973025134869;5402.297701298826;3998.4202290667836;5109.744512774365;5642.153676948449;5919;5928.7332070056955;5850.6782126983;5855.970720146393;5864.325602555697;5875.383084776101;5877.9412205877825;5269.710165940872;5438.864028399282;5446.537044351235;5454.836354909359;5831.504322132602;5209.869753256161;5221.973890130525;5224.138017227153;5226.137687281594;5227.2159176123505;12830.87169128306;19017.668763186583;19431;19690.901545492325;19772.80227197724;2077.480629842539;2148.871067735941;2213.302809614966;2785.56823692326;2859.510568407601;9862.90137098627;10337;12789.93605031969;13101.803472947913;13305.667358316023;1807.9276828926827;1833.8624603154817;1842.4213546164851;1867.6078023615057;1895.2797936783934;62297.68851155761;63800.68099659518;65146.67426662884;66595;67889;10045;10158.796824063478;10202.948985255027;10243.436610986468;10254.846177307347;13228.272445015424;13290.601281961557;13310.401031953392;13322.467101316033;13337.733245335234;7381.557106573623;7506.587137707478;7557.849342144629;7568.659410326549;7608.657610407434;7364.263573642593;7377.483576149725;7408.592527410937;7416.0729908761405;7420.183779784219;4285.871423857289;4305.720128191658;4329.480462344539;4348.260795664744;4464.419625448671;1628.4381888248536;1706.428346503935;1764.5059383372677;1779.2260366740509;1819.5633048068369;849.4223927729204;878.714417814213;894.3739382432193;929.1405449958761;1024.4672770159475;14896.553103406915;16204.918975405048;16243.269052892649;16399.262033208535;16708.41520546775;897.2149369301861;902.3322741171486;906.7959709065408;952.4285428742837;1018.5060245780791;8939.776505587282;8959.865602015974;9030.142136497023;9052.547372631341;9186.26509879208;383583;386179;387018;409184;421867;45584.544154558695;70518.64740676264;72922.27077729261;75992.62003689946;78557.21442785613;1024.59528486249;1031.51003273446;1038.6624347087227;1039.8804137524282;1068.9305195162135;13995.650108746955;14301.64245893861;14551.595643986384;14563.563093107225;14658.267086645837;32451.837740811145;32469.35061298808;32687.673123269415;33022.66977330196;34040;49258.75370623124;50706;50944.74527627338;51260;51303.23045154251;7299.890501642586;7380.114386273682;7428.517146385468;7493.625318734151;7495.400367970658;8027.638756256099;11098.389588572705;11771.176017679023;12083.637490875288;12402.441890114786;7950.761477155695;9561;9651.71044868655;9908.603655853973;10317.48412579383;9512.2865785065;9692.612295508101;10201.081902628799;10340.482975851328;10395.32430392022;8250.628721707657;8659.437136586102;10211.7447063824;10404.219683523917;10545.736356591147;7001.684924178322;7064.293570642894;7258.782236532912;7315.158756743042;7526.134494533198;8143.959280203561;9933.701988940344;10735.302205356627;10814.891851081704;10904.563817447213 07:44:14 INFO - PROCESS | 31526 | |3;mootools.html;1385.009718051594;1499.437710858428;1515.6059424549615;1705.5480297721099;1866.7386565880788;7802.1417644059175;7980.960095199531;7982.720604778834;7991.720289789866;7997.0803357613895;7829.295363417291;7987.680492780296;8003.839923201533;8043.316318112953;8050.879236811453;1965.6953172258252;2292.5758734634105;2317.1079134533156;2318.53629274145;2357.3045951444365;2322.8606283622953;2330.5804955108074;2335.1126571902737;2335.1243283768586;2340.134150364359;2309.90760369585;2317.339558225906;2319.686842276288;2320.0835669910375;2320.396696858812;2248.5053288276636;2325.6278995360663;2326.499802542453;2327.278543651465;2328.871912044837;2291.117919600949;2299.367673889677;2309.9653505197434;2326.3951372643064;2328.8020518255967;8042.316403105743;8097.2712455879255;8107.391945604044;8112.472689275178;8118.918810811875;4866.805327786884;4989.925151122736;4991.750412479398;4995.025969935864;4995.050940321327;3178.475551533994;3223.2103134732142;3276.3611095836322;3276.426625340556;3281.2289112058647;946.8958414574391;964.5370222293268;1000.5497526113205;1002.5588740953957;1003.5584342889106;11116.666500005012;11127.554897804079;11135.220534562584;11154.219204655596;11167.162462815322;4479.977600111979;4534.77326133692;4584.587387135107;4602.171609110393;4609.700369475973;8731.825363492695;8739.694110706096;8796.91203087961;8798.076201998825;8799.032106468283;4389.604935555815;4835.492273311322;4930.975345123252;4954.058728841508;4955.628327875424;4505.684602077823;4516.345129956204;4574.702644328108;4575.336576196433;4578.702384345007;3545.503629491873;3600.1719604491113;3600.873969411058;3648.945265821015;3650.926981460409;1015.6800607808665;1036.4144258493927;1066.1896958311738;1068.5992752717732;1069.4652673663168;861.6984055580622;869.3827382558454;880.1638443478593;880.264978742757;885.5749240364661;7120.145582530026;7140.642967851587;7147.89278160828;7214.206437291894;7215.458840586872;1063.6808957312776;1067.8985496377832;1095.7972775036644;1097.5390336058874;1115.4422788605698;5098.9490105098475;5121.897562048738;5157.8452646420665;5162.1224391853475;5163.302954101148;9616.23070154386;9666.661666841626;9868.259880508991;10071.295009349422;10076.748081298027;9876.111149996535;9913.851292230478;9952.651657191964;9956.751081223027;10038.498075096217;7331.78004659861;7484.176740558534;7542.132654744774;7715.267049630276;7823.765287041398;7138.357547820721;7144.749668808042;7152.856942861218;7167.749128780468;7224.349808517049;8401.280725479335;8649.610767515604;8778.912210878065;8856;8902.154295341932;8723.040465548911;9034.051424600586;9078.273738101068;9088.09119088086;9113.04313047147;6094.939050609437;6233.719482623203;6234.0337247726675;6988.196357418758;7113.359797618033;7415.592142432002;7509.098908131059;7535;7535.886961695689;7536.623168841646;6940.861182776417;6979.162500499972;7051.717931282897;7119.394851437686;7207.495475316678;6927.653617319214;6959.373656370951;7080.256573059754;7229.421646268391;7243.311885370881;6789.966050169717;6809.489288303298;7046.330598593126;7066.293370662893;7070.681819318246;6226.346233645402;6229.408206220402;6251.343608920998;6251.34360892118;6253.312135664983;6182.505399567934;6205.2553693555255;6227.283862355887;6240.344763799736;6243.344448832989 07:44:14 INFO - PROCESS | 31526 | |4;prototype.html;336.5473438225587;337.30010228775296;339.4687314353036;342.209496064092;347.57595733205494;5808.099744539592;5809.825705228839;5810.18657387965;5820.243368362112;5843.123531470271;5763.366029736726;5777.422257774231;5778.942210577893;5781.537477001841;5782.508486778629;4527.6151527120155;4528.343390208418;4535.659825513083;4537.4328208973875;4539.795709193094;4532.342810292505;4542.273236282195;4542.863714088583;4543.591076803087;4544.091181763644;4261.936070958923;4339.848105316315;4444.711093778894;4488.865334039984;4490.50604433512;4417.337399390085;4435.68950173488;4447.888802779924;4457.153140903218;4460.754658493782;3939.3697008478507;3965.484487016698;3966.5636779954184;3971.5631280559114;3979.064919743858;5345.385280692732;5417.59368047398;5572.916406253909;5587.776488940438;5609.691466969315;5180.559652429548;5191.299174611417;5195.922061169085;5201.089809283398;5207.453217412193;6174.660393678346;6176.938230617681;6181.3818618138275;6181.783637572708;6193.59741616798;4354.477462704464;4355.412019377375;4359.476862776455;4366.628836548897;4371;6207.068939659087;6423.807285781388;6426.807195784134;6436.871262574769;6439.227292724856;4441.333799930037;4469.508354081048;4470.932936005963;4477.462704475483;4480.977595112069;4503.774811259424;4504.954950450519;4506.414166158378;4509.444241736661;4510.977445112753;5167.069927413102;5175.81884634036;5176.559992400613;5176.767045482962;5177.715225662625;6190.50475961922;6192.845178870474;6205.2553693557065;6205.6586887721605;6207.720652570645;1591.594143493425;1613.8789590780739;1614.3461897931356;1615.6284054667492;1616.3696158498194;1070.9571617135384;1086.5708045322212;1099.6316234061678;1113.2986218682179;1115.1970581181536;5763;5769.249997500382;5803.448672376117;5816.680082595498;5889.852753681193;6121.602095863755;6232;6329.019002054689;6342.048692696132;6444.967775161188;5964.582479226413;5966.105084237312;5967.880642387128;5968.761249550056;5975.19334889793;3406.880759173417;3440.913977150541;3445.1042728890166;3449;3449.137715571107;6735.8989615155815;6748.156480439945;6751.932480675228;6759.391654751096;6763.661816909135;6357.682115894187;6531.3142120077655;6539.411452969255;6541.640209788412;6559.147310849655;6743.504903185754;6769.966150169218;6771.661416929134;6774.627395493295;6776.69504872282;6413.454856337077;6424.486041116793;6430.710618022106;6433.5496515243485;6435.616342486201;6316.6841657916;6357.14178585885;6358.078078678658;6370.108184854032;6371.490280777434;6663.533552651268;6693.364130407604;6714.060031595678;6719.764808231688;6724.966375168093;4022.678185745192;4148.439960605279;4245.1934132514725;4294.291441912174;4306.4832220133785;6283.685815709105;6457.709403076967;6480.060391243338;6480.837979050561;6482.222133344029;6224.62652240867;6228.56400051992;6236.656983865931;6239.032949892774;6242.812715618538;6174.753009879554;6183.876322473615;6223.284322302993;6241.157443745036;6242.219722534684;6132.41742034506;6134.079888016833;6146.631202127886;6147.72335244924;6148.1699970503405;5674.858128546819;5923.229980102559;6020.277566692025;6141.662208578392;6267.2792628848265;6055.061465472859;6066.302375226729;6097.567071738049;6104.114903338902;6107.6640784757265 07:44:14 INFO - PROCESS | 31526 | |5;yui.html;791.7545560876129;796.6813274690127;800.0599295827401;806.8063664720465;816.9591520423979;13791.241481718502;13986.300684965761;14039.157650540961;14047.297635118255;14048;11963.940180299109;12371.319577423239;12378;12384;12386.876131238685;675.0953722012503;813.0893399392688;819.0949001353508;833.6957010691084;836.2933321343455;829.1915382502073;829.5852073963018;829.8589239829244;830.1532436914343;830.161536847782;859.8495263328924;865.8225063861893;866.0386970462781;867.3754896474528;867.6095756909384;855.1234984141242;855.9743207703779;856.5117882806802;857.4126723194569;858.7337925243195;525.6451894970879;635.8124353315783;636.0173531893236;638.9137466442064;646.5409559212965;13621.18272903619;14173.29133543329;14195.432182712679;14203.64490887736;14212.289385530683;13017.609471715863;13369;13434;13550.59348219555;13722.245276509788;9595.616175353047;9661.178799802025;9744.805103897954;9838.11456968869;9883;3585.2470981094;3589.353916295066;3658.579263384718;3659.981700091509;3747.2505498900055;47631.52368476306;48255.75872120652;48329.27506087411;48335;48341.516584834055;10584.682459526226;10615.416152111708;10664.253502254767;10720.249582529304;10722.78554428907;19076;19117.33089341894;19119.235230590897;19132.904335478233;19149;7388.37198838094;7455.925440745632;7590.354819840375;7691.961540192263;7693.4614576979075;4247.469066366704;4342.761148136819;4342.913141737147;4349.760763158057;4408.603225709638;3219.5331676907185;3231.5475833383343;3241.0600925731746;3253.934921301608;3276.8525416355847;568.0967262053355;574.7758374234052;581.640185688879;582.7872826418327;594.3165359836223;474.32408817435015;505.5273319446256;522.040903091217;565.3498476751686;681.8418662815783;7724.845503089907;8101.6354264058255;8108.635111420001;8152.429329946846;8241.711540096068;551.4843621214178;575.1372940589116;592.9110633405023;607.4138456389517;669.7521916890781;3772.981135094307;3778.848846046182;3805.5813860475328;3899.454076429302;3951.9604803951593;54249.72875135599;55814;56051.15923261154;57263.42736572581;58601.70699146477;48761;49106.772330692016;49642.50357496379;50340.244896326585;50539;44222.33666495005;44548.55451445444;44706.55293447089;44732.55267447349;44948.77525612351;8246.711365102192;8280.751577452686;8301.958490207511;8356.61836376654;8674.175953284428;32166.356672865943;32407.027789166365;32689;34219.315613688086;35306.11734706653;42280;42528.787356063025;42582.5741742591;43855.561444386425;44147.688923330235;11186.832197517206;11193.104551636012;11568.479418426023;11582.768344632892;11773.234739742233;11514.884851151717;11692.35692036946;12008.219465734699;12676.366181691063;12929.870701292866;10539.525721342405;10754.569817207537;10760.192985526273;11020.559177632806;11541.826872597087;7414.332710056121;10170.949145254226;11041.613543526259;11281.830772538255;11648.825267621161;10675.466226688479;11087.501062452047;11307.038901693448;11372.886271137513;11707.824382634097;9213.723588292361;9336.113069258681;9638.132568068908;9745.12293893553;9811.460369679737;8062.879056814035;8573;8685.782855428664;10010.249231307535;10050.447225402673 07:44:14 INFO - PROCESS | 31526 | __end_tp_report 07:44:14 INFO - PROCESS | 31526 | __start_cc_report 07:44:14 INFO - PROCESS | 31526 | _x_x_mozilla_cycle_collect,961 07:44:14 INFO - PROCESS | 31526 | __end_cc_report 07:44:14 INFO - PROCESS | 31526 | __startTimestamp1456328654737__endTimestamp 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | ------- Summary: start ------- 07:44:14 INFO - PROCESS | 31526 | Number of tests: 6 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#0] dojo.html Cycles:165 Average:5214.76 Median:5395.49 stddev:564.72 (10.5%) stddev-sans-first:542.65 07:44:14 INFO - PROCESS | 31526 | Values: 3146.8 3197.0 3222.1 3225.2 3273.2 5133.1 5186.5 5188.4 5211.3 5244.4 5212.6 5246.6 5272.0 5281.8 5301.0 4769.8 4796.5 4811.3 4816.3 4944.3 4846.8 4858.6 4885.3 4911.3 4935.1 4714.9 4738.2 4803.2 4807.4 4820.1 4726.0 4732.2 4736.1 4759.3 4764.3 4674.6 4715.8 4728.7 4755.5 4772.8 5064.6 5076.1 5086.8 5089.4 5116.4 5597.3 5599.8 5600.3 5613.6 5634.3 5554.4 5678.9 5699.2 5723.8 5753.3 5250.9 5253.3 5254.1 5258.8 5270.1 5557.1 5728.1 5728.4 5736.3 5741.8 5525.7 5563.1 5577.4 5588.0 5638.6 5568.6 5615.3 5619.6 5621.5 5626.0 5505.2 5585.8 5596.3 5602.9 5698.4 5530.4 5542.7 5549.7 5551.0 5561.9 4310.4 4324.4 4332.1 4358.5 4369.7 3843.0 3885.0 3924.0 3936.0 3938.2 5255.1 5270.7 5277.5 5278.9 5295.2 5600.3 5609.6 5610.4 5611.5 5616.6 5136.9 5139.3 5164.7 5197.7 5232.3 4778.9 4809.5 4816.2 4817.1 4858.5 5797.4 5850.1 5868.1 5868.3 5877.3 5577.8 5593.1 5594.7 5607.4 5632.3 5844.5 5874.9 5878.4 5878.4 5881.9 5405.1 5533.4 5541.4 5584.6 5639.4 5600.3 5608.4 5637.6 5641.3 5643.1 5409.7 5462.9 5479.3 5483.6 5528.3 5392.9 5453.5 5486.7 5491.1 5505.5 5379.5 5395.5 5397.5 5404.8 5410.9 5428.9 5499.4 5510.2 5523.6 5562.3 5295.0 5297.0 5322.8 5366.2 5389.2 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#1] ext.html Cycles:180 Average:43810.00 Median:20429.38 stddev:71599.20 (350.5%) stddev-sans-first:71726.32 07:44:14 INFO - PROCESS | 31526 | Values: 532.7 533.4 540.8 553.5 555.0 28390.3 37170.8 37445.8 37496.0 37524.2 40412.8 40860.2 40862.0 40903.0 40979.4 8371.4 8542.8 8597.1 8608.4 8612.6 8431.1 8549.9 8569.7 8572.7 8576.5 8537.4 8890.5 8891.0 8891.6 8913.2 8738.0 8827.2 8836.6 8840.1 8845.0 8471.8 8569.0 8604.1 8618.0 8621.1 39829.0 40167.0 40184.6 40222.4 40249.4 3403.9 3724.3 3966.9 4016.5 4046.3 29810.5 30183.7 30226.2 30954.2 31056.4 3701.9 3722.1 3738.2 3748.6 3829.6 256090.0 257340.0 257942.0 258336.0 258648.0 51564.0 58246.3 58908.4 59061.4 59078.0 59578.4 59679.7 59760.4 59835.7 60014.0 12492.8 13381.8 13405.7 13472.5 14969.5 10712.0 10778.3 10779.4 10789.4 10790.4 19018.4 19118.1 19164.5 19791.9 19841.5 7167.7 7307.9 7376.2 7406.5 7466.8 910.8 988.7 1069.4 1078.6 1094.9 24448.6 24552.5 24670.1 24808.4 24861.0 968.7 1051.2 1053.6 1183.5 1186.6 13350.5 13407.7 13626.9 14045.6 14241.5 295521.0 297947.0 299212.0 299653.0 299875.5 52279.7 52755.7 53054.7 53076.5 53257.0 1262.3 1273.7 1283.6 1331.9 1339.2 24931.6 26180.1 26466.1 26647.7 26660.5 42584.4 44065.6 44377.0 44378.8 44546.8 180684.0 276486.0 282674.0 282751.0 282962.0 28791.7 29354.7 29518.7 29623.6 29670.3 39123.0 39630.8 40315.4 40526.6 40684.8 30365.4 31337.8 31367.0 31936.8 32160.4 36209.0 36565.8 36910.0 36930.0 37574.6 35918.0 36570.5 37156.8 37158.3 37183.0 27659.3 28065.2 29775.3 31947.5 32065.4 23894.4 23902.6 23978.4 24186.8 24243.6 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#2] jquery.html Cycles:180 Average:23946.45 Median:213076.44 stddev:65415.09 (30.7%) stddev-sans-first:65574.63 07:44:14 INFO - PROCESS | 31526 | Values: 361.9 362.4 364.1 370.8 371.1 13872.9 16812.7 17031.8 17171.4 17956.6 16313.8 16597.8 16804.4 16833.4 16867.8 5211.0 5291.7 5374.8 5395.0 5402.3 3998.4 5109.7 5642.2 5919.0 5928.7 5850.7 5856.0 5864.3 5875.4 5877.9 5269.7 5438.9 5446.5 5454.8 5831.5 5209.9 5222.0 5224.1 5226.1 5227.2 12830.9 19017.7 19431.0 19690.9 19772.8 2077.5 2148.9 2213.3 2785.6 2859.5 9862.9 10337.0 12789.9 13101.8 13305.7 1807.9 1833.9 1842.4 1867.6 1895.3 62297.7 63800.7 65146.7 66595.0 67889.0 10045.0 10158.8 10202.9 10243.4 10254.8 13228.3 13290.6 13310.4 13322.5 13337.7 7381.6 7506.6 7557.8 7568.7 7608.7 7364.3 7377.5 7408.6 7416.1 7420.2 4285.9 4305.7 4329.5 4348.3 4464.4 1628.4 1706.4 1764.5 1779.2 1819.6 849.4 878.7 894.4 929.1 1024.5 14896.6 16204.9 16243.3 16399.3 16708.4 897.2 902.3 906.8 952.4 1018.5 8939.8 8959.9 9030.1 9052.5 9186.3 383583.0 386179.0 387018.0 409184.0 421867.0 45584.5 70518.6 72922.3 75992.6 78557.2 1024.6 1031.5 1038.7 1039.9 1068.9 13995.7 14301.6 14551.6 14563.6 14658.3 32451.8 32469.4 32687.7 33022.7 34040.0 49258.8 50706.0 50944.7 51260.0 51303.2 7299.9 7380.1 7428.5 7493.6 7495.4 8027.6 11098.4 11771.2 12083.6 12402.4 7950.8 9561.0 9651.7 9908.6 10317.5 9512.3 9692.6 10201.1 10340.5 10395.3 8250.6 8659.4 10211.7 10404.2 10545.7 7001.7 7064.3 7258.8 7315.2 7526.1 8144.0 9933.7 10735.3 10814.9 10904.6 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#3] mootools.html Cycles:180 Average:5527.77 Median:6228.35 stddev:2919.36 (46.9%) stddev-sans-first:2910.95 07:44:14 INFO - PROCESS | 31526 | Values: 1385.0 1499.4 1515.6 1705.5 1866.7 7802.1 7981.0 7982.7 7991.7 7997.1 7829.3 7987.7 8003.8 8043.3 8050.9 1965.7 2292.6 2317.1 2318.5 2357.3 2322.9 2330.6 2335.1 2335.1 2340.1 2309.9 2317.3 2319.7 2320.1 2320.4 2248.5 2325.6 2326.5 2327.3 2328.9 2291.1 2299.4 2310.0 2326.4 2328.8 8042.3 8097.3 8107.4 8112.5 8118.9 4866.8 4989.9 4991.8 4995.0 4995.1 3178.5 3223.2 3276.4 3276.4 3281.2 946.9 964.5 1000.5 1002.6 1003.6 11116.7 11127.6 11135.2 11154.2 11167.2 4480.0 4534.8 4584.6 4602.2 4609.7 8731.8 8739.7 8796.9 8798.1 8799.0 4389.6 4835.5 4931.0 4954.1 4955.6 4505.7 4516.3 4574.7 4575.3 4578.7 3545.5 3600.2 3600.9 3648.9 3650.9 1015.7 1036.4 1066.2 1068.6 1069.5 861.7 869.4 880.2 880.3 885.6 7120.1 7140.6 7147.9 7214.2 7215.5 1063.7 1067.9 1095.8 1097.5 1115.4 5098.9 5121.9 5157.8 5162.1 5163.3 9616.2 9666.7 9868.3 10071.3 10076.7 9876.1 9913.9 9952.7 9956.8 10038.5 7331.8 7484.2 7542.1 7715.3 7823.8 7138.4 7144.7 7152.9 7167.7 7224.3 8401.3 8649.6 8778.9 8856.0 8902.2 8723.0 9034.1 9078.3 9088.1 9113.0 6094.9 6233.7 6234.0 6988.2 7113.4 7415.6 7509.1 7535.0 7535.9 7536.6 6940.9 6979.2 7051.7 7119.4 7207.5 6927.7 6959.4 7080.3 7229.4 7243.3 6790.0 6809.5 7046.3 7066.3 7070.7 6226.3 6229.4 6251.3 6251.3 6253.3 6182.5 6205.3 6227.3 6240.3 6243.3 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#4] prototype.html Cycles:180 Average:5190.39 Median:5810.01 stddev:1557.28 (26.8%) stddev-sans-first:1518.44 07:44:14 INFO - PROCESS | 31526 | Values: 336.5 337.3 339.5 342.2 347.6 5808.1 5809.8 5810.2 5820.2 5843.1 5763.4 5777.4 5778.9 5781.5 5782.5 4527.6 4528.3 4535.7 4537.4 4539.8 4532.3 4542.3 4542.9 4543.6 4544.1 4261.9 4339.8 4444.7 4488.9 4490.5 4417.3 4435.7 4447.9 4457.2 4460.8 3939.4 3965.5 3966.6 3971.6 3979.1 5345.4 5417.6 5572.9 5587.8 5609.7 5180.6 5191.3 5195.9 5201.1 5207.5 6174.7 6176.9 6181.4 6181.8 6193.6 4354.5 4355.4 4359.5 4366.6 4371.0 6207.1 6423.8 6426.8 6436.9 6439.2 4441.3 4469.5 4470.9 4477.5 4481.0 4503.8 4505.0 4506.4 4509.4 4511.0 5167.1 5175.8 5176.6 5176.8 5177.7 6190.5 6192.8 6205.3 6205.7 6207.7 1591.6 1613.9 1614.3 1615.6 1616.4 1071.0 1086.6 1099.6 1113.3 1115.2 5763.0 5769.2 5803.4 5816.7 5889.9 6121.6 6232.0 6329.0 6342.0 6445.0 5964.6 5966.1 5967.9 5968.8 5975.2 3406.9 3440.9 3445.1 3449.0 3449.1 6735.9 6748.2 6751.9 6759.4 6763.7 6357.7 6531.3 6539.4 6541.6 6559.1 6743.5 6770.0 6771.7 6774.6 6776.7 6413.5 6424.5 6430.7 6433.5 6435.6 6316.7 6357.1 6358.1 6370.1 6371.5 6663.5 6693.4 6714.1 6719.8 6725.0 4022.7 4148.4 4245.2 4294.3 4306.5 6283.7 6457.7 6480.1 6480.8 6482.2 6224.6 6228.6 6236.7 6239.0 6242.8 6174.8 6183.9 6223.3 6241.2 6242.2 6132.4 6134.1 6146.6 6147.7 6148.2 5674.9 5923.2 6020.3 6141.7 6267.3 6055.1 6066.3 6097.6 6104.1 6107.7 07:44:14 INFO - PROCESS | 31526 | 07:44:14 INFO - PROCESS | 31526 | [#5] yui.html Cycles:180 Average:13580.86 Median:22711.55 stddev:15550.80 (68.5%) stddev-sans-first:15564.76 07:44:14 INFO - PROCESS | 31526 | Values: 791.8 796.7 800.1 806.8 817.0 13791.2 13986.3 14039.2 14047.3 14048.0 11963.9 12371.3 12378.0 12384.0 12386.9 675.1 813.1 819.1 833.7 836.3 829.2 829.6 829.9 830.2 830.2 859.8 865.8 866.0 867.4 867.6 855.1 856.0 856.5 857.4 858.7 525.6 635.8 636.0 638.9 646.5 13621.2 14173.3 14195.4 14203.6 14212.3 13017.6 13369.0 13434.0 13550.6 13722.2 9595.6 9661.2 9744.8 9838.1 9883.0 3585.2 3589.4 3658.6 3660.0 3747.3 47631.5 48255.8 48329.3 48335.0 48341.5 10584.7 10615.4 10664.3 10720.2 10722.8 19076.0 19117.3 19119.2 19132.9 19149.0 7388.4 7455.9 7590.4 7692.0 7693.5 4247.5 4342.8 4342.9 4349.8 4408.6 3219.5 3231.5 3241.1 3253.9 3276.9 568.1 574.8 581.6 582.8 594.3 474.3 505.5 522.0 565.3 681.8 7724.8 8101.6 8108.6 8152.4 8241.7 551.5 575.1 592.9 607.4 669.8 3773.0 3778.8 3805.6 3899.5 3952.0 54249.7 55814.0 56051.2 57263.4 58601.7 48761.0 49106.8 49642.5 50340.2 50539.0 44222.3 44548.6 44706.6 44732.6 44948.8 8246.7 8280.8 8302.0 8356.6 8674.2 32166.4 32407.0 32689.0 34219.3 35306.1 42280.0 42528.8 42582.6 43855.6 44147.7 11186.8 11193.1 11568.5 11582.8 11773.2 11514.9 11692.4 12008.2 12676.4 12929.9 10539.5 10754.6 10760.2 11020.6 11541.8 7414.3 10170.9 11041.6 11281.8 11648.8 10675.5 11087.5 11307.0 11372.9 11707.8 9213.7 9336.1 9638.1 9745.1 9811.5 8062.9 8573.0 8685.8 10010.2 10050.4 07:44:14 INFO - PROCESS | 31526 | -------- Summary: end -------- 07:44:14 INFO - PROCESS | 31526 | 07:44:15 INFO - TEST-INFO | 31526: exit 0 07:44:15 INFO - TEST-OK | dromaeo_css | took 1114646ms 07:44:15 INFO - TEST-START | kraken 07:44:15 INFO - operating with platform_type : linux_ 07:44:15 INFO - Initialising browser for kraken test... 07:44:15 INFO - TEST-INFO | started process 31713 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprF5kfp/profile http://localhost:48267/getInfo.html) 07:44:19 INFO - PROCESS | 31713 | __metrics Screen width/height:1600/1200 07:44:19 INFO - PROCESS | 31713 | colorDepth:24 07:44:19 INFO - PROCESS | 31713 | Browser inner width/height: 1024/697 07:44:19 INFO - PROCESS | 31713 | __metrics 07:44:20 INFO - PROCESS | 31713 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:21 INFO - TEST-INFO | 31713: exit 0 07:44:21 INFO - Browser initialized. 07:44:21 INFO - Running cycle 1/1 for kraken test... 07:44:21 INFO - TEST-INFO | started process 31799 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprF5kfp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:33 INFO - PROCESS | 31799 | RSS: Main: 147558400 07:44:33 INFO - PROCESS | 31799 | 07:44:36 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:36 INFO - PROCESS | 31799 | RSS: Main: 191205376 07:44:36 INFO - PROCESS | 31799 | 07:44:39 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-dft) 07:44:39 INFO - PROCESS | 31799 | RSS: Main: 180035584 07:44:39 INFO - PROCESS | 31799 | 07:44:42 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-fft) 07:44:43 INFO - PROCESS | 31799 | RSS: Main: 164040704 07:44:43 INFO - PROCESS | 31799 | 07:44:45 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48267/tests/kraken/driver.html?testName=audio-oscillator) 07:44:45 INFO - PROCESS | 31799 | RSS: Main: 165994496 07:44:45 INFO - PROCESS | 31799 | 07:44:48 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:48 INFO - PROCESS | 31799 | RSS: Main: 169369600 07:44:48 INFO - PROCESS | 31799 | 07:44:51 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:52 INFO - PROCESS | 31799 | RSS: Main: 170799104 07:44:52 INFO - PROCESS | 31799 | 07:44:55 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48267/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:56 INFO - PROCESS | 31799 | RSS: Main: 169652224 07:44:56 INFO - PROCESS | 31799 | 07:44:59 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48267/tests/kraken/driver.html?testName=json-parse-financial) 07:44:59 INFO - PROCESS | 31799 | RSS: Main: 170549248 07:44:59 INFO - PROCESS | 31799 | 07:45:01 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:01 INFO - PROCESS | 31799 | RSS: Main: 182239232 07:45:01 INFO - PROCESS | 31799 | 07:45:03 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:04 INFO - PROCESS | 31799 | RSS: Main: 179904512 07:45:04 INFO - PROCESS | 31799 | 07:45:06 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:06 INFO - PROCESS | 31799 | RSS: Main: 193056768 07:45:06 INFO - PROCESS | 31799 | 07:45:09 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:09 INFO - PROCESS | 31799 | RSS: Main: 200146944 07:45:09 INFO - PROCESS | 31799 | 07:45:12 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:13 INFO - PROCESS | 31799 | RSS: Main: 200622080 07:45:13 INFO - PROCESS | 31799 | 07:45:14 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:48267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48267/tests/kraken/driver.html?testName=ai-astar) 07:45:15 INFO - PROCESS | 31799 | RSS: Main: 258609152 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | __start_tp_report 07:45:15 INFO - PROCESS | 31799 | _x_x_mozilla_page_load 07:45:15 INFO - PROCESS | 31799 | _x_x_mozilla_page_load_details 07:45:15 INFO - PROCESS | 31799 | |i|pagename|runs| 07:45:15 INFO - PROCESS | 31799 | |0;ai-astar;111;110;106;111;111;110;100;111;110;110 07:45:15 INFO - PROCESS | 31799 | |1;audio-beat-detection;151;127;150;168;128;155;161;126;172;130 07:45:15 INFO - PROCESS | 31799 | |2;audio-dft;162;162;161;161;160;160;160;164;161;161 07:45:15 INFO - PROCESS | 31799 | |3;audio-fft;73;72;102;95;73;72;74;120;94;73 07:45:15 INFO - PROCESS | 31799 | |4;audio-oscillator;97;97;141;95;96;96;144;96;97;147 07:45:15 INFO - PROCESS | 31799 | |5;imaging-gaussian-blur;119;116;115;115;114;115;115;115;115;115 07:45:15 INFO - PROCESS | 31799 | |6;imaging-darkroom;146;146;146;146;147;145;146;146;147;146 07:45:15 INFO - PROCESS | 31799 | |7;imaging-desaturate;96;97;96;96;96;96;96;97;96;96 07:45:15 INFO - PROCESS | 31799 | |8;json-parse-financial;57;56;56;56;57;63;57;66;54;55 07:45:15 INFO - PROCESS | 31799 | |9;json-stringify-tinderbox;66;67;66;67;67;67;67;67;70;68 07:45:15 INFO - PROCESS | 31799 | |10;stanford-crypto-aes;84;82;85;85;83;84;83;88;85;84 07:45:15 INFO - PROCESS | 31799 | |11;stanford-crypto-ccm;122;126;123;123;117;123;116;120;124;118 07:45:15 INFO - PROCESS | 31799 | |12;stanford-crypto-pbkdf2;151;141;151;151;150;141;151;165;143;142 07:45:15 INFO - PROCESS | 31799 | |13;stanford-crypto-sha256-iterative;68;69;70;69;68;72;68;68;68;69 07:45:15 INFO - PROCESS | 31799 | __end_tp_report 07:45:15 INFO - PROCESS | 31799 | __start_cc_report 07:45:15 INFO - PROCESS | 31799 | _x_x_mozilla_cycle_collect,997 07:45:15 INFO - PROCESS | 31799 | __end_cc_report 07:45:15 INFO - PROCESS | 31799 | __startTimestamp1456328715044__endTimestamp 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | ------- Summary: start ------- 07:45:15 INFO - PROCESS | 31799 | Number of tests: 14 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.50 (3.2%) stddev-sans-first:3.63 07:45:15 INFO - PROCESS | 31799 | Values: 111.0 110.0 106.0 111.0 111.0 110.0 100.0 111.0 110.0 110.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:153.00 stddev:17.77 (11.6%) stddev-sans-first:18.78 07:45:15 INFO - PROCESS | 31799 | Values: 151.0 127.0 150.0 168.0 128.0 155.0 161.0 126.0 172.0 130.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 07:45:15 INFO - PROCESS | 31799 | Values: 162.0 162.0 161.0 161.0 160.0 160.0 160.0 164.0 161.0 161.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#3] audio-fft Cycles:10 Average:84.80 Median:73.00 stddev:16.95 (23.2%) stddev-sans-first:17.43 07:45:15 INFO - PROCESS | 31799 | Values: 73.0 72.0 102.0 95.0 73.0 72.0 74.0 120.0 94.0 73.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:23.10 (24.1%) stddev-sans-first:23.97 07:45:15 INFO - PROCESS | 31799 | Values: 97.0 97.0 141.0 95.0 96.0 96.0 144.0 96.0 97.0 147.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 07:45:15 INFO - PROCESS | 31799 | Values: 119.0 116.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:45:15 INFO - PROCESS | 31799 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 147.0 146.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:45:15 INFO - PROCESS | 31799 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.77 (6.6%) stddev-sans-first:3.99 07:45:15 INFO - PROCESS | 31799 | Values: 57.0 56.0 56.0 56.0 57.0 63.0 57.0 66.0 54.0 55.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 07:45:15 INFO - PROCESS | 31799 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 70.0 68.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:1.64 (1.9%) stddev-sans-first:1.73 07:45:15 INFO - PROCESS | 31799 | Values: 84.0 82.0 85.0 85.0 83.0 84.0 83.0 88.0 85.0 84.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:123.00 stddev:3.29 (2.7%) stddev-sans-first:3.48 07:45:15 INFO - PROCESS | 31799 | Values: 122.0 126.0 123.0 123.0 117.0 123.0 116.0 120.0 124.0 118.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:151.00 stddev:7.34 (4.9%) stddev-sans-first:7.73 07:45:15 INFO - PROCESS | 31799 | Values: 151.0 141.0 151.0 151.0 150.0 141.0 151.0 165.0 143.0 142.0 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - PROCESS | 31799 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 07:45:15 INFO - PROCESS | 31799 | Values: 68.0 69.0 70.0 69.0 68.0 72.0 68.0 68.0 68.0 69.0 07:45:15 INFO - PROCESS | 31799 | -------- Summary: end -------- 07:45:15 INFO - PROCESS | 31799 | 07:45:15 INFO - TEST-INFO | 31799: exit 0 07:45:16 INFO - TEST-OK | kraken | took 60516ms 07:45:16 INFO - SUITE-END | took 1175s 07:45:16 INFO - Completed test suite (00:19:35) 07:45:16 INFO - Working with test: dromaeo_css 07:45:16 INFO - Generating results file: dromaeo_css 07:45:16 INFO - Working with test: kraken 07:45:16 INFO - Generating results file: kraken 07:45:16 INFO - javascript benchmark 07:45:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:45:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:45:16 INFO - process_Request line: dromaeo_css 6806.06 graph.html#tests=[[72,1,35]] 07:45:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:45:16 INFO - process_Request line: kraken 1518.00 graph.html#tests=[[232,1,35]] 07:45:16 INFO - RETURN: dromaeo_css: 6806.06 07:45:16 INFO - RETURN: kraken: 1518.00 07:45:16 INFO - javascript benchmark 07:45:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3146.826924519152, 3196.984015079924, 3222.146131275211, 3225.242068113993, 3273.165342837576, 5133.050385678652, 5186.455422180668, 5188.403333616626, 5211.3225280713505, 5244.396894357145, 5212.556932660719, 5246.606504512168, 5272.0, 5281.841544753664, 5300.973495132529, 4769.833055843046, 4796.52034796521, 4811.326414302001, 4816.3016362627395, 4944.283078953567, 4846.830360937368, 4858.5627293543575, 4885.267209918523, 4911.287863259825, 4935.111679897617, 4714.90570188596, 4738.241881298975, 4803.18345881201, 4807.4471435784635, 4820.108279968217, 4726.0, 4732.1718699227495, 4736.147493451177, 4759.309900064472, 4764.309175169616, 4674.602658774008, 4715.834945776881, 4728.66899317048, 4755.548222918817, 4772.785224664898, 5064.594832413398, 5076.111680455905, 5086.79652813887, 5089.3638295213095, 5116.411612664554, 5597.3003374578175, 5599.832005039855, 5600.271964644611, 5613.578981576398, 5634.267545219136, 5554.416786237468, 5678.943210567924, 5699.2306038684665, 5723.799667011676, 5753.33836608787, 5250.8687282817855, 5253.343332083489, 5254.106801843695, 5258.789648414059, 5270.077736396115, 5557.083081291542, 5728.1407788831175, 5728.369879313273, 5736.282964629421, 5741.799037033684, 5525.668459892419, 5563.054280772279, 5577.358603760619, 5587.972060139755, 5638.577106717013, 5568.582356323292, 5615.326160860723, 5619.578531610064, 5621.522170615462, 5626.0, 5505.174223866452, 5585.804496842591, 5596.3284405870745, 5602.887942241132, 5698.373178950312, 5530.446955304437, 5542.722863856871, 5549.667019978814, 5551.0, 5561.916571251434, 4310.396544483775, 4324.437823083042, 4332.1119170569955, 4358.498772641124, 4369.737815731066, 3843.0392401899526, 3885.048163200034, 3923.9803800980812, 3936.0159960009996, 3938.212357528506, 5255.08036093682, 5270.657407268592, 5277.498637629419, 5278.874580844879, 5295.205719142159, 5600.27196464457, 5609.635373700697, 5610.410906854721, 5611.466910643482, 5616.606837521416, 5136.897262054738, 5139.331886854759, 5164.690118592896, 5197.7401129943355, 5232.319798426181, 4778.880527986758, 4809.495003024632, 4816.181249187646, 4817.0606731686985, 4858.514148585184, 5797.36229014808, 5850.0932355484965, 5868.119782032644, 5868.295804503487, 5877.294724633071, 5577.8047768327915, 5593.07714227148, 5594.748236329294, 5607.41122182165, 5632.32412110533, 5844.503217226414, 5874.853128671817, 5878.353381127987, 5878.412158784087, 5881.911771323348, 5405.135178371442, 5533.446655334435, 5541.445855414427, 5584.553235741049, 5639.379668236409, 5600.299962504687, 5608.355039170385, 5637.57718171147, 5641.323041235078, 5643.068893632669, 5409.7024663642305, 5462.945370546244, 5479.2602998594675, 5483.561315094703, 5528.281323427928, 5392.865178370572, 5453.536449401845, 5486.698231597141, 5491.093969494988, 5505.476979686923, 5379.515843574097, 5395.487428694268, 5397.514223719884, 5404.8108316208745, 5410.945890541044, 5428.91856622143, 5499.3675727291875, 5510.173473978935, 5523.613347065667, 5562.276904002454, 5295.0, 5297.046531624344, 5322.787088516416, 5366.195070739421, 5389.164679474688], "unit": "score", "name": "dojo.html", "value": 5179.356422003638}, {"lowerIsBetter": false, "replicates": [532.7043490862571, 533.3945971322551, 540.8107162493128, 553.5405613340929, 555.0176188146983, 28390.29024274394, 37170.8141459293, 37445.81277093617, 37496.0, 37524.24951500972, 40412.79793601035, 40860.18279634405, 40862.0, 40903.0, 40979.385309220386, 8371.414001019946, 8542.829143417128, 8597.140285971383, 8608.440451370672, 8612.612432440555, 8431.072582015973, 8549.871751923725, 8569.742907712778, 8572.671235958436, 8576.485410875337, 8537.445066070717, 8890.511021893793, 8890.955545222265, 8891.555422228896, 8913.15325044123, 8738.0, 8827.205551500363, 8836.602352894135, 8840.071792461764, 8845.0, 8471.83056338876, 8569.0, 8604.139586041409, 8618.0, 8621.094785047542, 39829.0, 40167.0, 40184.59815401838, 40222.396664050066, 40249.396259056135, 3403.8638454461793, 3724.2923844469465, 3966.920661586781, 4016.49793775778, 4046.2514434829354, 29810.485060263705, 30183.69816301853, 30226.244343891358, 30954.226144346347, 31056.378872422425, 3701.9444708329397, 3722.1253005543676, 3738.1776009277914, 3748.5689145748042, 3829.5787463379006, 256090.0, 257340.0, 257942.0, 258336.0, 258648.0, 51564.0, 58246.30167530703, 58908.410915890294, 59061.40938590645, 59078.0, 59578.40421595815, 59679.70160149258, 59760.40239597635, 59835.700821495615, 60014.0, 12492.75014499705, 13381.799273010913, 13405.731885362238, 13472.5284615038, 14969.476068337555, 10712.0, 10778.29941053829, 10779.353238805697, 10789.40658263803, 10790.406527641055, 19018.42944711661, 19118.139683714267, 19164.520886977938, 19791.901040494704, 19841.503962400766, 7167.749128780468, 7307.890381644173, 7376.225496322809, 7406.518576292524, 7466.813329666802, 910.7632015675839, 988.678679429174, 1069.4064794039382, 1078.6386560502162, 1094.9124070074374, 24448.633270500955, 24552.5089498209, 24670.13654522119, 24808.37979050502, 24861.0, 968.6658102954469, 1051.2168434516334, 1053.599632139782, 1183.47335435732, 1186.590626233948, 13350.46598136083, 13407.731845363038, 13626.863731362757, 14045.648858778612, 14241.50154744579, 295521.0, 297947.0, 299212.0, 299653.0, 299875.50186747214, 52279.73860130675, 52755.73622131865, 53054.73472632612, 53076.46923530715, 53257.0, 1262.3309645887693, 1273.7134144817342, 1283.557172775391, 1331.8668133186604, 1339.1563315111418, 24931.62602560927, 26180.08369707051, 26466.073687421616, 26647.7335226653, 26660.466790664464, 42584.361234582124, 44065.559344406145, 44377.0, 44378.77810610926, 44546.77726611346, 180684.0, 276486.0, 282674.0, 282751.0, 282962.0, 28791.712082878905, 29354.706452935196, 29518.704812951597, 29623.555646665747, 29670.258243544085, 39123.0, 39630.80184599059, 40315.395269071574, 40526.59473405228, 40684.79657601693, 30365.392692146474, 31337.8433107833, 31367.0, 31936.840315799203, 32160.35679286448, 36209.0, 36565.81717091398, 36910.0, 36930.0, 37574.624253757116, 35918.0, 36570.45144322891, 37156.814215928745, 37158.25683486369, 37183.0, 27659.308517287227, 28065.158045258675, 29775.255618609706, 31947.520787187746, 32065.358692826478, 23894.402639934142, 23902.641460378458, 23978.40053998664, 24186.75813241845, 24243.636345455187], "unit": "score", "name": "ext.html", "value": 17805.928895628294}, {"lowerIsBetter": false, "replicates": [361.9330423871583, 362.4110819917634, 364.0679859559526, 370.80532720321827, 371.0667670807917, 13872.861271387283, 16812.66374672506, 17031.82968170318, 17171.399001034966, 17956.55108622285, 16313.83686163138, 16597.751033734505, 16804.411845585408, 16833.41083062093, 16867.83132168678, 5210.973945130269, 5291.708956007418, 5374.758135883875, 5394.973025134869, 5402.297701298826, 3998.4202290667836, 5109.744512774365, 5642.153676948449, 5919.0, 5928.7332070056955, 5850.6782126983, 5855.970720146393, 5864.325602555697, 5875.383084776101, 5877.9412205877825, 5269.710165940872, 5438.864028399282, 5446.537044351235, 5454.836354909359, 5831.504322132602, 5209.869753256161, 5221.973890130525, 5224.138017227153, 5226.137687281594, 5227.2159176123505, 12830.87169128306, 19017.668763186583, 19431.0, 19690.901545492325, 19772.80227197724, 2077.480629842539, 2148.871067735941, 2213.302809614966, 2785.56823692326, 2859.510568407601, 9862.90137098627, 10337.0, 12789.93605031969, 13101.803472947913, 13305.667358316023, 1807.9276828926827, 1833.8624603154817, 1842.4213546164851, 1867.6078023615057, 1895.2797936783934, 62297.68851155761, 63800.68099659518, 65146.67426662884, 66595.0, 67889.0, 10045.0, 10158.796824063478, 10202.948985255027, 10243.436610986468, 10254.846177307347, 13228.272445015424, 13290.601281961557, 13310.401031953392, 13322.467101316033, 13337.733245335234, 7381.557106573623, 7506.587137707478, 7557.849342144629, 7568.659410326549, 7608.657610407434, 7364.263573642593, 7377.483576149725, 7408.592527410937, 7416.0729908761405, 7420.183779784219, 4285.871423857289, 4305.720128191658, 4329.480462344539, 4348.260795664744, 4464.419625448671, 1628.4381888248536, 1706.428346503935, 1764.5059383372677, 1779.2260366740509, 1819.5633048068369, 849.4223927729204, 878.714417814213, 894.3739382432193, 929.1405449958761, 1024.4672770159475, 14896.553103406915, 16204.918975405048, 16243.269052892649, 16399.262033208535, 16708.41520546775, 897.2149369301861, 902.3322741171486, 906.7959709065408, 952.4285428742837, 1018.5060245780791, 8939.776505587282, 8959.865602015974, 9030.142136497023, 9052.547372631341, 9186.26509879208, 383583.0, 386179.0, 387018.0, 409184.0, 421867.0, 45584.544154558695, 70518.64740676264, 72922.27077729261, 75992.62003689946, 78557.21442785613, 1024.59528486249, 1031.51003273446, 1038.6624347087227, 1039.8804137524282, 1068.9305195162135, 13995.650108746955, 14301.64245893861, 14551.595643986384, 14563.563093107225, 14658.267086645837, 32451.837740811145, 32469.35061298808, 32687.673123269415, 33022.66977330196, 34040.0, 49258.75370623124, 50706.0, 50944.74527627338, 51260.0, 51303.23045154251, 7299.890501642586, 7380.114386273682, 7428.517146385468, 7493.625318734151, 7495.400367970658, 8027.638756256099, 11098.389588572705, 11771.176017679023, 12083.637490875288, 12402.441890114786, 7950.761477155695, 9561.0, 9651.71044868655, 9908.603655853973, 10317.48412579383, 9512.2865785065, 9692.612295508101, 10201.081902628799, 10340.482975851328, 10395.32430392022, 8250.628721707657, 8659.437136586102, 10211.7447063824, 10404.219683523917, 10545.736356591147, 7001.684924178322, 7064.293570642894, 7258.782236532912, 7315.158756743042, 7526.134494533198, 8143.959280203561, 9933.701988940344, 10735.302205356627, 10814.891851081704, 10904.563817447213], "unit": "score", "name": "jquery.html", "value": 8206.4460897747}, {"lowerIsBetter": false, "replicates": [1385.009718051594, 1499.437710858428, 1515.6059424549615, 1705.5480297721099, 1866.7386565880788, 7802.1417644059175, 7980.960095199531, 7982.720604778834, 7991.720289789866, 7997.0803357613895, 7829.295363417291, 7987.680492780296, 8003.839923201533, 8043.316318112953, 8050.879236811453, 1965.6953172258252, 2292.5758734634105, 2317.1079134533156, 2318.53629274145, 2357.3045951444365, 2322.8606283622953, 2330.5804955108074, 2335.1126571902737, 2335.1243283768586, 2340.134150364359, 2309.90760369585, 2317.339558225906, 2319.686842276288, 2320.0835669910375, 2320.396696858812, 2248.5053288276636, 2325.6278995360663, 2326.499802542453, 2327.278543651465, 2328.871912044837, 2291.117919600949, 2299.367673889677, 2309.9653505197434, 2326.3951372643064, 2328.8020518255967, 8042.316403105743, 8097.2712455879255, 8107.391945604044, 8112.472689275178, 8118.918810811875, 4866.805327786884, 4989.925151122736, 4991.750412479398, 4995.025969935864, 4995.050940321327, 3178.475551533994, 3223.2103134732142, 3276.3611095836322, 3276.426625340556, 3281.2289112058647, 946.8958414574391, 964.5370222293268, 1000.5497526113205, 1002.5588740953957, 1003.5584342889106, 11116.666500005012, 11127.554897804079, 11135.220534562584, 11154.219204655596, 11167.162462815322, 4479.977600111979, 4534.77326133692, 4584.587387135107, 4602.171609110393, 4609.700369475973, 8731.825363492695, 8739.694110706096, 8796.91203087961, 8798.076201998825, 8799.032106468283, 4389.604935555815, 4835.492273311322, 4930.975345123252, 4954.058728841508, 4955.628327875424, 4505.684602077823, 4516.345129956204, 4574.702644328108, 4575.336576196433, 4578.702384345007, 3545.503629491873, 3600.1719604491113, 3600.873969411058, 3648.945265821015, 3650.926981460409, 1015.6800607808665, 1036.4144258493927, 1066.1896958311738, 1068.5992752717732, 1069.4652673663168, 861.6984055580622, 869.3827382558454, 880.1638443478593, 880.264978742757, 885.5749240364661, 7120.145582530026, 7140.642967851587, 7147.89278160828, 7214.206437291894, 7215.458840586872, 1063.6808957312776, 1067.8985496377832, 1095.7972775036644, 1097.5390336058874, 1115.4422788605698, 5098.9490105098475, 5121.897562048738, 5157.8452646420665, 5162.1224391853475, 5163.302954101148, 9616.23070154386, 9666.661666841626, 9868.259880508991, 10071.295009349422, 10076.748081298027, 9876.111149996535, 9913.851292230478, 9952.651657191964, 9956.751081223027, 10038.498075096217, 7331.78004659861, 7484.176740558534, 7542.132654744774, 7715.267049630276, 7823.765287041398, 7138.357547820721, 7144.749668808042, 7152.856942861218, 7167.749128780468, 7224.349808517049, 8401.280725479335, 8649.610767515604, 8778.912210878065, 8856.0, 8902.154295341932, 8723.040465548911, 9034.051424600586, 9078.273738101068, 9088.09119088086, 9113.04313047147, 6094.939050609437, 6233.719482623203, 6234.0337247726675, 6988.196357418758, 7113.359797618033, 7415.592142432002, 7509.098908131059, 7535.0, 7535.886961695689, 7536.623168841646, 6940.861182776417, 6979.162500499972, 7051.717931282897, 7119.394851437686, 7207.495475316678, 6927.653617319214, 6959.373656370951, 7080.256573059754, 7229.421646268391, 7243.311885370881, 6789.966050169717, 6809.489288303298, 7046.330598593126, 7066.293370662893, 7070.681819318246, 6226.346233645402, 6229.408206220402, 6251.343608920998, 6251.34360892118, 6253.312135664983, 6182.505399567934, 6205.2553693555255, 6227.283862355887, 6240.344763799736, 6243.344448832989], "unit": "score", "name": "mootools.html", "value": 4491.1659395357565}, {"lowerIsBetter": false, "replicates": [336.5473438225587, 337.30010228775296, 339.4687314353036, 342.209496064092, 347.57595733205494, 5808.099744539592, 5809.825705228839, 5810.18657387965, 5820.243368362112, 5843.123531470271, 5763.366029736726, 5777.422257774231, 5778.942210577893, 5781.537477001841, 5782.508486778629, 4527.6151527120155, 4528.343390208418, 4535.659825513083, 4537.4328208973875, 4539.795709193094, 4532.342810292505, 4542.273236282195, 4542.863714088583, 4543.591076803087, 4544.091181763644, 4261.936070958923, 4339.848105316315, 4444.711093778894, 4488.865334039984, 4490.50604433512, 4417.337399390085, 4435.68950173488, 4447.888802779924, 4457.153140903218, 4460.754658493782, 3939.3697008478507, 3965.484487016698, 3966.5636779954184, 3971.5631280559114, 3979.064919743858, 5345.385280692732, 5417.59368047398, 5572.916406253909, 5587.776488940438, 5609.691466969315, 5180.559652429548, 5191.299174611417, 5195.922061169085, 5201.089809283398, 5207.453217412193, 6174.660393678346, 6176.938230617681, 6181.3818618138275, 6181.783637572708, 6193.59741616798, 4354.477462704464, 4355.412019377375, 4359.476862776455, 4366.628836548897, 4371.0, 6207.068939659087, 6423.807285781388, 6426.807195784134, 6436.871262574769, 6439.227292724856, 4441.333799930037, 4469.508354081048, 4470.932936005963, 4477.462704475483, 4480.977595112069, 4503.774811259424, 4504.954950450519, 4506.414166158378, 4509.444241736661, 4510.977445112753, 5167.069927413102, 5175.81884634036, 5176.559992400613, 5176.767045482962, 5177.715225662625, 6190.50475961922, 6192.845178870474, 6205.2553693557065, 6205.6586887721605, 6207.720652570645, 1591.594143493425, 1613.8789590780739, 1614.3461897931356, 1615.6284054667492, 1616.3696158498194, 1070.9571617135384, 1086.5708045322212, 1099.6316234061678, 1113.2986218682179, 1115.1970581181536, 5763.0, 5769.249997500382, 5803.448672376117, 5816.680082595498, 5889.852753681193, 6121.602095863755, 6232.0, 6329.019002054689, 6342.048692696132, 6444.967775161188, 5964.582479226413, 5966.105084237312, 5967.880642387128, 5968.761249550056, 5975.19334889793, 3406.880759173417, 3440.913977150541, 3445.1042728890166, 3449.0, 3449.137715571107, 6735.8989615155815, 6748.156480439945, 6751.932480675228, 6759.391654751096, 6763.661816909135, 6357.682115894187, 6531.3142120077655, 6539.411452969255, 6541.640209788412, 6559.147310849655, 6743.504903185754, 6769.966150169218, 6771.661416929134, 6774.627395493295, 6776.69504872282, 6413.454856337077, 6424.486041116793, 6430.710618022106, 6433.5496515243485, 6435.616342486201, 6316.6841657916, 6357.14178585885, 6358.078078678658, 6370.108184854032, 6371.490280777434, 6663.533552651268, 6693.364130407604, 6714.060031595678, 6719.764808231688, 6724.966375168093, 4022.678185745192, 4148.439960605279, 4245.1934132514725, 4294.291441912174, 4306.4832220133785, 6283.685815709105, 6457.709403076967, 6480.060391243338, 6480.837979050561, 6482.222133344029, 6224.62652240867, 6228.56400051992, 6236.656983865931, 6239.032949892774, 6242.812715618538, 6174.753009879554, 6183.876322473615, 6223.284322302993, 6241.157443745036, 6242.219722534684, 6132.41742034506, 6134.079888016833, 6146.631202127886, 6147.72335244924, 6148.1699970503405, 5674.858128546819, 5923.229980102559, 6020.277566692025, 6141.662208578392, 6267.2792628848265, 6055.061465472859, 6066.302375226729, 6097.567071738049, 6104.114903338902, 6107.6640784757265], "unit": "score", "name": "prototype.html", "value": 4692.585275014855}, {"lowerIsBetter": false, "replicates": [791.7545560876129, 796.6813274690127, 800.0599295827401, 806.8063664720465, 816.9591520423979, 13791.241481718502, 13986.300684965761, 14039.157650540961, 14047.297635118255, 14048.0, 11963.940180299109, 12371.319577423239, 12378.0, 12384.0, 12386.876131238685, 675.0953722012503, 813.0893399392688, 819.0949001353508, 833.6957010691084, 836.2933321343455, 829.1915382502073, 829.5852073963018, 829.8589239829244, 830.1532436914343, 830.161536847782, 859.8495263328924, 865.8225063861893, 866.0386970462781, 867.3754896474528, 867.6095756909384, 855.1234984141242, 855.9743207703779, 856.5117882806802, 857.4126723194569, 858.7337925243195, 525.6451894970879, 635.8124353315783, 636.0173531893236, 638.9137466442064, 646.5409559212965, 13621.18272903619, 14173.29133543329, 14195.432182712679, 14203.64490887736, 14212.289385530683, 13017.609471715863, 13369.0, 13434.0, 13550.59348219555, 13722.245276509788, 9595.616175353047, 9661.178799802025, 9744.805103897954, 9838.11456968869, 9883.0, 3585.2470981094, 3589.353916295066, 3658.579263384718, 3659.981700091509, 3747.2505498900055, 47631.52368476306, 48255.75872120652, 48329.27506087411, 48335.0, 48341.516584834055, 10584.682459526226, 10615.416152111708, 10664.253502254767, 10720.249582529304, 10722.78554428907, 19076.0, 19117.33089341894, 19119.235230590897, 19132.904335478233, 19149.0, 7388.37198838094, 7455.925440745632, 7590.354819840375, 7691.961540192263, 7693.4614576979075, 4247.469066366704, 4342.761148136819, 4342.913141737147, 4349.760763158057, 4408.603225709638, 3219.5331676907185, 3231.5475833383343, 3241.0600925731746, 3253.934921301608, 3276.8525416355847, 568.0967262053355, 574.7758374234052, 581.640185688879, 582.7872826418327, 594.3165359836223, 474.32408817435015, 505.5273319446256, 522.040903091217, 565.3498476751686, 681.8418662815783, 7724.845503089907, 8101.6354264058255, 8108.635111420001, 8152.429329946846, 8241.711540096068, 551.4843621214178, 575.1372940589116, 592.9110633405023, 607.4138456389517, 669.7521916890781, 3772.981135094307, 3778.848846046182, 3805.5813860475328, 3899.454076429302, 3951.9604803951593, 54249.72875135599, 55814.0, 56051.15923261154, 57263.42736572581, 58601.70699146477, 48761.0, 49106.772330692016, 49642.50357496379, 50340.244896326585, 50539.0, 44222.33666495005, 44548.55451445444, 44706.55293447089, 44732.55267447349, 44948.77525612351, 8246.711365102192, 8280.751577452686, 8301.958490207511, 8356.61836376654, 8674.175953284428, 32166.356672865943, 32407.027789166365, 32689.0, 34219.315613688086, 35306.11734706653, 42280.0, 42528.787356063025, 42582.5741742591, 43855.561444386425, 44147.688923330235, 11186.832197517206, 11193.104551636012, 11568.479418426023, 11582.768344632892, 11773.234739742233, 11514.884851151717, 11692.35692036946, 12008.219465734699, 12676.366181691063, 12929.870701292866, 10539.525721342405, 10754.569817207537, 10760.192985526273, 11020.559177632806, 11541.826872597087, 7414.332710056121, 10170.949145254226, 11041.613543526259, 11281.830772538255, 11648.825267621161, 10675.466226688479, 11087.501062452047, 11307.038901693448, 11372.886271137513, 11707.824382634097, 9213.723588292361, 9336.113069258681, 9638.132568068908, 9745.12293893553, 9811.460369679737, 8062.879056814035, 8573.0, 8685.782855428664, 10010.249231307535, 10050.447225402673], "unit": "score", "name": "yui.html", "value": 6231.194589686489}], "name": "dromaeo_css", "value": 6806.061935830441}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 106.0, 111.0, 111.0, 110.0, 100.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 150.0, 168.0, 128.0, 155.0, 161.0, 126.0, 172.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 102.0, 95.0, 73.0, 72.0, 74.0, 120.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 95.0, 96.0, 96.0, 144.0, 96.0, 97.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 63.0, 57.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 85.0, 85.0, 83.0, 84.0, 83.0, 88.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 123.0, 123.0, 117.0, 123.0, 116.0, 120.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [151.0, 141.0, 151.0, 151.0, 150.0, 141.0, 151.0, 165.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 68.0, 72.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1518.0}]} 07:45:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1518.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6806.06"}}} 07:45:16 INFO - Return code: 0 07:45:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:45:16 INFO - # TBPL SUCCESS # 07:45:16 INFO - Running post-action listener: _resource_record_post_action 07:45:16 INFO - Running post-run listener: _resource_record_post_run 07:45:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 533811200; Read time: 0; Write time: 449252 07:45:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240807936; Read time: 0; Write time: 240264 07:45:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293003264; Read time: 0; Write time: 208988 07:45:17 INFO - Running post-run listener: _upload_blobber_files 07:45:17 INFO - Blob upload gear active. 07:45:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:45: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 07:45: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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:45: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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:45:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:18 INFO - (blobuploader) - INFO - Done attempting. 07:45:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:45:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:45:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:19 INFO - (blobuploader) - INFO - Done attempting. 07:45:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:19 INFO - Return code: 0 07:45:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:45:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b0682c76519d5adeb1776d97ddffd73ed5c9639d5817f75a8afc51ef513c3b298f30cb469d2c825b2b06e23cb39bed449544bab056b4110da65edc2246648a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083557fcb2b8807c635631ff2be2d1895b0a2e6b85f0bf73459ac4426c60006b2c3a59006103c007df41ce2df4935f0d26d1c1ba29484171d2578f1314716b9a"} 07:45:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:45:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:45:19 INFO - Contents: 07:45:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b0682c76519d5adeb1776d97ddffd73ed5c9639d5817f75a8afc51ef513c3b298f30cb469d2c825b2b06e23cb39bed449544bab056b4110da65edc2246648a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083557fcb2b8807c635631ff2be2d1895b0a2e6b85f0bf73459ac4426c60006b2c3a59006103c007df41ce2df4935f0d26d1c1ba29484171d2578f1314716b9a"} 07:45:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:19 INFO - Copying logs to upload dir... 07:45:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:45:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.993775 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-24 07:45:19.251221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 07:45:19.254727) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b0682c76519d5adeb1776d97ddffd73ed5c9639d5817f75a8afc51ef513c3b298f30cb469d2c825b2b06e23cb39bed449544bab056b4110da65edc2246648a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083557fcb2b8807c635631ff2be2d1895b0a2e6b85f0bf73459ac4426c60006b2c3a59006103c007df41ce2df4935f0d26d1c1ba29484171d2578f1314716b9a"} build_url:https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/ND-LFTTDRgegvtu1QtST9w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3b0682c76519d5adeb1776d97ddffd73ed5c9639d5817f75a8afc51ef513c3b298f30cb469d2c825b2b06e23cb39bed449544bab056b4110da65edc2246648a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083557fcb2b8807c635631ff2be2d1895b0a2e6b85f0bf73459ac4426c60006b2c3a59006103c007df41ce2df4935f0d26d1c1ba29484171d2578f1314716b9a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 07:45:19.279533) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:45:19.279850) ========= 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=836cfdc75598d54cb747368e000001a9-1456327476.688946-600047069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 07:45:19.365020) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 07:45:19.365341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 07:45:19.365623) ========= ========= Total master_lag: 0.27 =========