builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1455142675.78 results: success (0) buildid: 20160210113059 builduid: fce68feea856429bad03dcef1418b12d revision: 348a56aaff85a04577c394f7c8e5e25125686c8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.780496) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.781027) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.784500) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006446 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.833554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.833878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.858153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.861494) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.914985) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.915335) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.915739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:55.916077) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 14:17:56-- 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% 43.5M=0s 2016-02-10 14:17:56 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.110504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.110848) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016282 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.162259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.162963) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 348a56aaff85a04577c394f7c8e5e25125686c8d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 348a56aaff85a04577c394f7c8e5e25125686c8d --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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 14:17:56,827 truncating revision to first 12 chars 2016-02-10 14:17:56,827 Setting DEBUG logging. 2016-02-10 14:17:56,827 attempt 1/10 2016-02-10 14:17:56,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/348a56aaff85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 14:17:57,159 unpacking tar archive at: b2g-inbound-348a56aaff85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.823065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.823542) ========= echo 348a56aaff85a04577c394f7c8e5e25125686c8d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'348a56aaff85a04577c394f7c8e5e25125686c8d'] 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 348a56aaff85a04577c394f7c8e5e25125686c8d program finished with exit code 0 elapsedTime=0.004675 script_repo_revision: '348a56aaff85a04577c394f7c8e5e25125686c8d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.879862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.880652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 14:17:56.891186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-10 14:17:56.891534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:57 INFO - MultiFileLogger online at 20160210 14:17:57 in /builds/slave/test-pgo 14:17:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 14:17:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:17:57 INFO - {'append_to_log': False, 14:17:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:17:57 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:17:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:17:57 INFO - 'branch': 'B2G-Inbound', 14:17:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:57 INFO - 'config_files': ('talos/linux_config.py',), 14:17:57 INFO - 'default_actions': ('clobber', 14:17:57 INFO - 'read-buildbot-config', 14:17:57 INFO - 'download-and-extract', 14:17:57 INFO - 'populate-webroot', 14:17:57 INFO - 'create-virtualenv', 14:17:57 INFO - 'install', 14:17:57 INFO - 'run-tests'), 14:17:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:57 INFO - 'download_minidump_stackwalk': True, 14:17:57 INFO - 'download_symbols': 'ondemand', 14:17:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:57 INFO - 'installer_path': 'installer.exe', 14:17:57 INFO - 'log_level': 'info', 14:17:57 INFO - 'log_name': 'talos', 14:17:57 INFO - 'log_to_console': True, 14:17:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:57 INFO - 'opt_config_files': (), 14:17:57 INFO - 'pip_index': False, 14:17:57 INFO - 'sps_profile': False, 14:17:57 INFO - 'sps_profile_interval': 0, 14:17:57 INFO - 'suite': 'dromaeojs', 14:17:57 INFO - 'system_bits': '32', 14:17:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:57 INFO - 'title': 'talos-linux64-ix-057', 14:17:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:57 INFO - 'use_talos_json': True, 14:17:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:17:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:57 INFO - 'work_dir': 'build'} 14:17:57 INFO - ##### 14:17:57 INFO - ##### Running clobber step. 14:17:57 INFO - ##### 14:17:57 INFO - Running pre-action listener: _resource_record_pre_action 14:17:57 INFO - Running main action method: clobber 14:17:57 INFO - rmtree: /builds/slave/test-pgo/build 14:17:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:17:58 INFO - Running post-action listener: _resource_record_post_action 14:17:58 INFO - ##### 14:17:58 INFO - ##### Running read-buildbot-config step. 14:17:58 INFO - ##### 14:17:58 INFO - Running pre-action listener: _resource_record_pre_action 14:17:58 INFO - Running main action method: read_buildbot_config 14:17:58 INFO - Using buildbot properties: 14:17:58 INFO - { 14:17:58 INFO - "project": "", 14:17:58 INFO - "product": "firefox", 14:17:58 INFO - "script_repo_revision": "production", 14:17:58 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:17:58 INFO - "repository": "", 14:17:58 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:17:58 INFO - "buildid": "20160210113059", 14:17:58 INFO - "pgo_build": "True", 14:17:58 INFO - "basedir": "/builds/slave/test-pgo", 14:17:58 INFO - "buildnumber": 1139, 14:17:58 INFO - "slavename": "talos-linux64-ix-057", 14:17:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:17:58 INFO - "platform": "ubuntu64_hw", 14:17:58 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:17:58 INFO - "branch": "b2g-inbound", 14:17:58 INFO - "repo_path": "integration/b2g-inbound", 14:17:58 INFO - "revision": "348a56aaff85a04577c394f7c8e5e25125686c8d", 14:17:58 INFO - "stage_platform": "linux64-pgo", 14:17:58 INFO - "builduid": "fce68feea856429bad03dcef1418b12d", 14:17:58 INFO - "slavebuilddir": "test" 14:17:58 INFO - } 14:17:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:17:58 INFO - Running post-action listener: _resource_record_post_action 14:17:58 INFO - ##### 14:17:58 INFO - ##### Running download-and-extract step. 14:17:58 INFO - ##### 14:17:58 INFO - Running pre-action listener: _resource_record_pre_action 14:17:58 INFO - Running main action method: download_and_extract 14:17:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:58 INFO - https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/test_packages.json 14:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/test_packages.json 14:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:18:03 INFO - Downloaded 1448 bytes. 14:18:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:18:03 INFO - Using the following test package requirements: 14:18:03 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:18:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:18:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:18:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'jsshell-linux-x86_64.zip'], 14:18:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:18:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:18:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:18:03 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:18:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:18:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:18:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:03 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:18:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:07 INFO - Downloaded 23574995 bytes. 14:18:07 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'] 14:18:07 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 14:18:08 INFO - Return code: 0 14:18:08 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 14:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:08 INFO - https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:11 INFO - Downloaded 23574995 bytes. 14:18:11 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'] 14:18:11 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 14:18:12 INFO - Return code: 0 14:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:12 INFO - https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:13 INFO - Downloaded 10706547 bytes. 14:18:13 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'] 14:18:13 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 14:18:13 INFO - Return code: 0 14:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:13 INFO - https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HRl1kuz3RzORyZAJRhULKw/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 14:18:14 INFO - Downloaded 56572534 bytes. 14:18:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:14 INFO - mkdir: /builds/slave/test-pgo/properties 14:18:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:18:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:18:14 INFO - Contents: 14:18:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:15 INFO - Running post-action listener: _resource_record_post_action 14:18:15 INFO - Running post-action listener: set_extra_try_arguments 14:18:15 INFO - ##### 14:18:15 INFO - ##### Running populate-webroot step. 14:18:15 INFO - ##### 14:18:15 INFO - Running pre-action listener: _resource_record_pre_action 14:18:15 INFO - Running main action method: populate_webroot 14:18:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:15 INFO - '--tppagecycles', 14:18:15 INFO - '7'], 14:18:15 INFO - 'tests': ['tsvgm']}}, 14:18:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:18:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:18:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'tests': ['damp', 'tps']}, 14:18:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['damp', 'tps']}, 14:18:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:18:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:15 INFO - 'other': {'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'other_l64': {'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'other_nol64': {'tests': ['a11yr', 14:18:15 INFO - 'ts_paint', 14:18:15 INFO - 'tpaint', 14:18:15 INFO - 'sessionrestore', 14:18:15 INFO - 'sessionrestore_no_auto_restore']}, 14:18:15 INFO - 'svgr': {'tests': ['tsvgx', 14:18:15 INFO - 'tsvgr_opacity', 14:18:15 INFO - 'tart', 14:18:15 INFO - 'tscrollx', 14:18:15 INFO - 'cart']}, 14:18:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['tsvgx', 14:18:15 INFO - 'tsvgr_opacity', 14:18:15 INFO - 'tart', 14:18:15 INFO - 'tscrollx', 14:18:15 INFO - 'cart']}, 14:18:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'tests': ['tp5o']}, 14:18:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'talos_options': ['--e10s'], 14:18:15 INFO - 'tests': ['tp5o']}, 14:18:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'talos_options': ['--xperf_path', 14:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:15 INFO - 'tests': ['tp5n']}, 14:18:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:15 INFO - 'talos_options': ['--e10s', 14:18:15 INFO - '--xperf_path', 14:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:15 INFO - 'tests': ['tp5n']}}, 14:18:15 INFO - 'talos.zip': {'path': '', 14:18:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:15 INFO - Running post-action listener: _resource_record_post_action 14:18:15 INFO - ##### 14:18:15 INFO - ##### Running create-virtualenv step. 14:18:15 INFO - ##### 14:18:15 INFO - Running pre-action listener: _resource_record_pre_action 14:18:15 INFO - Running main action method: create_virtualenv 14:18:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:18:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:18:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:18:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:15 INFO - Using real prefix '/usr' 14:18:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:18 INFO - Installing pip.................done. 14:18:18 INFO - Return code: 0 14:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:18:18 INFO - Using env: {'DISPLAY': ':0', 14:18:18 INFO - 'HOME': '/home/cltbld', 14:18:18 INFO - 'LANG': 'en_US.UTF-8', 14:18:18 INFO - 'LANGUAGE': 'en_US:en', 14:18:18 INFO - 'LOGNAME': 'cltbld', 14:18:18 INFO - 'MAIL': '/var/mail/cltbld', 14:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:18 INFO - 'MOZ_NO_REMOTE': '1', 14:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:18 INFO - 'NO_EM_RESTART': '1', 14:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:18 INFO - 'SHELL': '/bin/bash', 14:18:18 INFO - 'SHLVL': '1', 14:18:18 INFO - 'TERM': 'linux', 14:18:18 INFO - 'TMOUT': '86400', 14:18:18 INFO - 'USER': 'cltbld', 14:18:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:18 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:18:18 INFO - Cleaning up... 14:18:18 INFO - Return code: 0 14:18:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:18:18 INFO - Using env: {'DISPLAY': ':0', 14:18:18 INFO - 'HOME': '/home/cltbld', 14:18:18 INFO - 'LANG': 'en_US.UTF-8', 14:18:18 INFO - 'LANGUAGE': 'en_US:en', 14:18:18 INFO - 'LOGNAME': 'cltbld', 14:18:18 INFO - 'MAIL': '/var/mail/cltbld', 14:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:18 INFO - 'MOZ_NO_REMOTE': '1', 14:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:18 INFO - 'NO_EM_RESTART': '1', 14:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:18 INFO - 'SHELL': '/bin/bash', 14:18:18 INFO - 'SHLVL': '1', 14:18:18 INFO - 'TERM': 'linux', 14:18:18 INFO - 'TMOUT': '86400', 14:18:18 INFO - 'USER': 'cltbld', 14:18:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:18 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 INFO - Downloading/unpacking psutil>=0.7.1 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:20 INFO - Installing collected packages: psutil 14:18:20 INFO - Running setup.py install for psutil 14:18:20 INFO - building 'psutil._psutil_linux' extension 14:18:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:18:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:18:21 INFO - building 'psutil._psutil_posix' extension 14:18:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:18:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:21 INFO - Successfully installed psutil 14:18:21 INFO - Cleaning up... 14:18:21 INFO - Return code: 0 14:18:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:21 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:18:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:18:21 INFO - Using env: {'DISPLAY': ':0', 14:18:21 INFO - 'HOME': '/home/cltbld', 14:18:21 INFO - 'LANG': 'en_US.UTF-8', 14:18:21 INFO - 'LANGUAGE': 'en_US:en', 14:18:21 INFO - 'LOGNAME': 'cltbld', 14:18:21 INFO - 'MAIL': '/var/mail/cltbld', 14:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:21 INFO - 'MOZ_NO_REMOTE': '1', 14:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:21 INFO - 'NO_EM_RESTART': '1', 14:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:21 INFO - 'SHELL': '/bin/bash', 14:18:21 INFO - 'SHLVL': '1', 14:18:21 INFO - 'TERM': 'linux', 14:18:21 INFO - 'TMOUT': '86400', 14:18:21 INFO - 'USER': 'cltbld', 14:18:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:21 INFO - '_': '/tools/buildbot/bin/python'} 14:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:23 INFO - Installing collected packages: mozsystemmonitor 14:18:23 INFO - Running setup.py install for mozsystemmonitor 14:18:23 INFO - Successfully installed mozsystemmonitor 14:18:23 INFO - Cleaning up... 14:18:23 INFO - Return code: 0 14:18:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:23 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:18:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:23 INFO - Using env: {'DISPLAY': ':0', 14:18:23 INFO - 'HOME': '/home/cltbld', 14:18:23 INFO - 'LANG': 'en_US.UTF-8', 14:18:23 INFO - 'LANGUAGE': 'en_US:en', 14:18:23 INFO - 'LOGNAME': 'cltbld', 14:18:23 INFO - 'MAIL': '/var/mail/cltbld', 14:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:23 INFO - 'MOZ_NO_REMOTE': '1', 14:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:23 INFO - 'NO_EM_RESTART': '1', 14:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:23 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:23 INFO - 'SHELL': '/bin/bash', 14:18:23 INFO - 'SHLVL': '1', 14:18:23 INFO - 'TERM': 'linux', 14:18:23 INFO - 'TMOUT': '86400', 14:18:23 INFO - 'USER': 'cltbld', 14:18:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:23 INFO - '_': '/tools/buildbot/bin/python'} 14:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:18:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:26 INFO - Downloading docopt-0.6.1.tar.gz 14:18:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:26 INFO - Running setup.py install for blobuploader 14:18:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:18:26 INFO - Running setup.py install for requests 14:18:26 INFO - Running setup.py install for docopt 14:18:26 INFO - Successfully installed blobuploader requests docopt 14:18:26 INFO - Cleaning up... 14:18:26 INFO - Return code: 0 14:18:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:26 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:18:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:26 INFO - Using env: {'DISPLAY': ':0', 14:18:26 INFO - 'HOME': '/home/cltbld', 14:18:26 INFO - 'LANG': 'en_US.UTF-8', 14:18:26 INFO - 'LANGUAGE': 'en_US:en', 14:18:26 INFO - 'LOGNAME': 'cltbld', 14:18:26 INFO - 'MAIL': '/var/mail/cltbld', 14:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:26 INFO - 'MOZ_NO_REMOTE': '1', 14:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:26 INFO - 'NO_EM_RESTART': '1', 14:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:26 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:26 INFO - 'SHELL': '/bin/bash', 14:18:26 INFO - 'SHLVL': '1', 14:18:26 INFO - 'TERM': 'linux', 14:18:26 INFO - 'TMOUT': '86400', 14:18:26 INFO - 'USER': 'cltbld', 14:18:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:26 INFO - '_': '/tools/buildbot/bin/python'} 14:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:27 INFO - Running setup.py (path:/tmp/pip-q4RK8H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:27 INFO - Running setup.py (path:/tmp/pip-ToQvFU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:27 INFO - Running setup.py (path:/tmp/pip-0eoeMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:27 INFO - Running setup.py (path:/tmp/pip-hakogN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:27 INFO - Running setup.py (path:/tmp/pip-pQVOkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:27 INFO - Running setup.py (path:/tmp/pip-xZseNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:27 INFO - Running setup.py (path:/tmp/pip-dTVYLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:27 INFO - Running setup.py (path:/tmp/pip-J2_AIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:27 INFO - Running setup.py (path:/tmp/pip-Nugvt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:27 INFO - Running setup.py (path:/tmp/pip-T_H9og-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:27 INFO - Running setup.py (path:/tmp/pip-6a5Uw4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:27 INFO - Running setup.py (path:/tmp/pip-bX3h4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:27 INFO - Running setup.py (path:/tmp/pip-Zh5e1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:28 INFO - Running setup.py (path:/tmp/pip-KI62ob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:28 INFO - Running setup.py (path:/tmp/pip-hYAt_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:28 INFO - Running setup.py (path:/tmp/pip-aaMXM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:28 INFO - Running setup.py (path:/tmp/pip-zySygV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:28 INFO - Running setup.py install for manifestparser 14:18:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:18:28 INFO - Running setup.py install for mozcrash 14:18:28 INFO - Running setup.py install for mozdebug 14:18:28 INFO - Running setup.py install for mozdevice 14:18:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:18:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:18:28 INFO - Running setup.py install for mozfile 14:18:28 INFO - Running setup.py install for mozhttpd 14:18:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:18:28 INFO - Running setup.py install for mozinfo 14:18:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for mozInstall 14:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for mozleak 14:18:29 INFO - Running setup.py install for mozlog 14:18:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for moznetwork 14:18:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for mozprocess 14:18:29 INFO - Running setup.py install for mozprofile 14:18:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for mozrunner 14:18:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:18:29 INFO - Running setup.py install for mozscreenshot 14:18:29 INFO - Running setup.py install for moztest 14:18:29 INFO - Running setup.py install for mozversion 14:18:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:18:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:30 INFO - Cleaning up... 14:18:30 INFO - Return code: 0 14:18:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:30 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:18:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:30 INFO - Using env: {'DISPLAY': ':0', 14:18:30 INFO - 'HOME': '/home/cltbld', 14:18:30 INFO - 'LANG': 'en_US.UTF-8', 14:18:30 INFO - 'LANGUAGE': 'en_US:en', 14:18:30 INFO - 'LOGNAME': 'cltbld', 14:18:30 INFO - 'MAIL': '/var/mail/cltbld', 14:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:30 INFO - 'MOZ_NO_REMOTE': '1', 14:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:30 INFO - 'NO_EM_RESTART': '1', 14:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:30 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:30 INFO - 'SHELL': '/bin/bash', 14:18:30 INFO - 'SHLVL': '1', 14:18:30 INFO - 'TERM': 'linux', 14:18:30 INFO - 'TMOUT': '86400', 14:18:30 INFO - 'USER': 'cltbld', 14:18:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:30 INFO - '_': '/tools/buildbot/bin/python'} 14:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:30 INFO - Running setup.py (path:/tmp/pip-I2Hwbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:30 INFO - Running setup.py (path:/tmp/pip-NKULOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:30 INFO - Running setup.py (path:/tmp/pip-m8CHGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:30 INFO - Running setup.py (path:/tmp/pip-vyFsJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:30 INFO - Running setup.py (path:/tmp/pip-oEG6DY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:30 INFO - Running setup.py (path:/tmp/pip-W5ghZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:30 INFO - Running setup.py (path:/tmp/pip-w10aX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:30 INFO - Running setup.py (path:/tmp/pip-xHcDDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:30 INFO - Running setup.py (path:/tmp/pip-UwTtte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:18:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:30 INFO - Running setup.py (path:/tmp/pip-S0Nxrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:31 INFO - Running setup.py (path:/tmp/pip-BiLIXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:31 INFO - Running setup.py (path:/tmp/pip-jjxET9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:31 INFO - Running setup.py (path:/tmp/pip-90mOuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:31 INFO - Running setup.py (path:/tmp/pip-zuzJFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:31 INFO - Running setup.py (path:/tmp/pip-IRxnV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:31 INFO - Running setup.py (path:/tmp/pip-qBwNHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:18:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:31 INFO - Running setup.py (path:/tmp/pip-jP_VQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:18:31 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)) 14:18:31 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)) 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:33 INFO - Downloading blessings-1.6.tar.gz 14:18:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:33 INFO - Installing collected packages: blessings 14:18:33 INFO - Running setup.py install for blessings 14:18:33 INFO - Successfully installed blessings 14:18:33 INFO - Cleaning up... 14:18:33 INFO - Return code: 0 14:18:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:18:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:18:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:18:33 INFO - Reading from file tmpfile_stdout 14:18:33 INFO - Current package versions: 14:18:33 INFO - argparse == 1.2.1 14:18:33 INFO - blessings == 1.6 14:18:33 INFO - blobuploader == 1.2.4 14:18:33 INFO - docopt == 0.6.1 14:18:33 INFO - manifestparser == 1.1 14:18:33 INFO - mozInstall == 1.12 14:18:33 INFO - mozcrash == 0.16 14:18:33 INFO - mozdebug == 0.1 14:18:33 INFO - mozdevice == 0.48 14:18:33 INFO - mozfile == 1.2 14:18:33 INFO - mozhttpd == 0.7 14:18:33 INFO - mozinfo == 0.9 14:18:33 INFO - mozleak == 0.1 14:18:33 INFO - mozlog == 3.1 14:18:33 INFO - moznetwork == 0.27 14:18:33 INFO - mozprocess == 0.22 14:18:33 INFO - mozprofile == 0.28 14:18:33 INFO - mozrunner == 6.11 14:18:33 INFO - mozscreenshot == 0.1 14:18:33 INFO - mozsystemmonitor == 0.0 14:18:33 INFO - moztest == 0.7 14:18:33 INFO - mozversion == 1.4 14:18:33 INFO - psutil == 3.1.1 14:18:33 INFO - requests == 1.2.3 14:18:33 INFO - wsgiref == 0.1.2 14:18:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:33 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:18:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:33 INFO - Using env: {'DISPLAY': ':0', 14:18:33 INFO - 'HOME': '/home/cltbld', 14:18:33 INFO - 'LANG': 'en_US.UTF-8', 14:18:33 INFO - 'LANGUAGE': 'en_US:en', 14:18:33 INFO - 'LOGNAME': 'cltbld', 14:18:33 INFO - 'MAIL': '/var/mail/cltbld', 14:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:33 INFO - 'MOZ_NO_REMOTE': '1', 14:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:33 INFO - 'NO_EM_RESTART': '1', 14:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:33 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:33 INFO - 'SHELL': '/bin/bash', 14:18:33 INFO - 'SHLVL': '1', 14:18:33 INFO - 'TERM': 'linux', 14:18:33 INFO - 'TMOUT': '86400', 14:18:33 INFO - 'USER': 'cltbld', 14:18:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:33 INFO - '_': '/tools/buildbot/bin/python'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:18:34 INFO - Cleaning up... 14:18:34 INFO - Return code: 0 14:18:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:18:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:34 INFO - Using env: {'DISPLAY': ':0', 14:18:34 INFO - 'HOME': '/home/cltbld', 14:18:34 INFO - 'LANG': 'en_US.UTF-8', 14:18:34 INFO - 'LANGUAGE': 'en_US:en', 14:18:34 INFO - 'LOGNAME': 'cltbld', 14:18:34 INFO - 'MAIL': '/var/mail/cltbld', 14:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:34 INFO - 'MOZ_NO_REMOTE': '1', 14:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:34 INFO - 'NO_EM_RESTART': '1', 14:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:34 INFO - 'SHELL': '/bin/bash', 14:18:34 INFO - 'SHLVL': '1', 14:18:34 INFO - 'TERM': 'linux', 14:18:34 INFO - 'TMOUT': '86400', 14:18:34 INFO - 'USER': 'cltbld', 14:18:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:34 INFO - '_': '/tools/buildbot/bin/python'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 INFO - Downloading/unpacking jsonschema 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:36 INFO - Downloading/unpacking functools32 (from jsonschema) 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:36 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:36 INFO - warning: no files found matching '*.txt' 14:18:36 INFO - no previously-included directories found matching 'build' 14:18:36 INFO - no previously-included directories found matching 'dist' 14:18:36 INFO - no previously-included directories found matching '.git*' 14:18:36 INFO - Installing collected packages: jsonschema, functools32 14:18:36 INFO - Running setup.py install for functools32 14:18:36 INFO - warning: no files found matching '*.txt' 14:18:36 INFO - no previously-included directories found matching 'build' 14:18:36 INFO - no previously-included directories found matching 'dist' 14:18:36 INFO - no previously-included directories found matching '.git*' 14:18:36 INFO - Successfully installed jsonschema functools32 14:18:36 INFO - Cleaning up... 14:18:36 INFO - Return code: 0 14:18:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:36 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 0x7fd855e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:18:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:18:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:18:36 INFO - Using env: {'DISPLAY': ':0', 14:18:36 INFO - 'HOME': '/home/cltbld', 14:18:36 INFO - 'LANG': 'en_US.UTF-8', 14:18:36 INFO - 'LANGUAGE': 'en_US:en', 14:18:36 INFO - 'LOGNAME': 'cltbld', 14:18:36 INFO - 'MAIL': '/var/mail/cltbld', 14:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:36 INFO - 'MOZ_NO_REMOTE': '1', 14:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:36 INFO - 'NO_EM_RESTART': '1', 14:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:36 INFO - 'SHELL': '/bin/bash', 14:18:36 INFO - 'SHLVL': '1', 14:18:36 INFO - 'TERM': 'linux', 14:18:36 INFO - 'TMOUT': '86400', 14:18:36 INFO - 'USER': 'cltbld', 14:18:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:36 INFO - '_': '/tools/buildbot/bin/python'} 14:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:36 INFO - Downloading/unpacking flake8 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:39 INFO - no previously-included directories found matching 'docs/_build' 14:18:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:39 INFO - Running setup.py install for pep8 14:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:39 INFO - no previously-included directories found matching 'docs/_build' 14:18:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:18:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:39 INFO - Cleaning up... 14:18:39 INFO - Return code: 0 14:18:39 INFO - Running post-action listener: _resource_record_post_action 14:18:39 INFO - Running post-action listener: _start_resource_monitoring 14:18:39 INFO - Starting resource monitoring. 14:18:39 INFO - ##### 14:18:39 INFO - ##### Running install step. 14:18:39 INFO - ##### 14:18:39 INFO - Running pre-action listener: _resource_record_pre_action 14:18:39 INFO - Running main action method: install 14:18:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:18:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:18:39 INFO - Reading from file tmpfile_stdout 14:18:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:18:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:18:39 INFO - Reading from file tmpfile_stdout 14:18:39 INFO - Output received: 14:18:39 INFO - Usage: mozinstall [options] installer 14:18:39 INFO - Options: 14:18:39 INFO - -h, --help show this help message and exit 14:18:39 INFO - -d DEST, --destination=DEST 14:18:39 INFO - Directory to install application into. [default: 14:18:39 INFO - "/builds/slave/test-pgo"] 14:18:39 INFO - --app=APP Application being installed. [default: firefox] 14:18:39 INFO - mkdir: /builds/slave/test-pgo/build/application 14:18:39 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'] 14:18:39 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 14:18:56 INFO - Reading from file tmpfile_stdout 14:18:56 INFO - Output received: 14:18:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:18:56 INFO - Running post-action listener: _resource_record_post_action 14:18:56 INFO - ##### 14:18:56 INFO - ##### Running run-tests step. 14:18:56 INFO - ##### 14:18:56 INFO - Running pre-action listener: _resource_record_pre_action 14:18:56 INFO - Running main action method: run_tests 14:18:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:18:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:18:56 INFO - Python 2.7.3 14:18:56 INFO - Return code: 0 14:18:56 INFO - grabbing minidump binary from tooltool 14:18: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')]} 14:18:56 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 0x2cb98c0>, '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 0x2cba7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:18:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:18:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:18:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:56 INFO - Return code: 0 14:18:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:18:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:18:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:18:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:18:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:18:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:18:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:18:57 INFO - Return code: 0 14:18:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:18:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:18:57 INFO - Using env: {'DISPLAY': ':0', 14:18:57 INFO - 'HOME': '/home/cltbld', 14:18:57 INFO - 'LANG': 'en_US.UTF-8', 14:18:57 INFO - 'LANGUAGE': 'en_US:en', 14:18:57 INFO - 'LOGNAME': 'cltbld', 14:18:57 INFO - 'MAIL': '/var/mail/cltbld', 14:18:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:18:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:57 INFO - 'MOZ_NO_REMOTE': '1', 14:18:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:57 INFO - 'NO_EM_RESTART': '1', 14:18:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:18:57 INFO - 'SHELL': '/bin/bash', 14:18:57 INFO - 'SHLVL': '1', 14:18:57 INFO - 'TERM': 'linux', 14:18:57 INFO - 'TMOUT': '86400', 14:18:57 INFO - 'USER': 'cltbld', 14:18:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161', 14:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:57 INFO - '_': '/tools/buildbot/bin/python'} 14:18:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:18:57 INFO - mozversion application_buildid: 20160210113059 14:18:57 INFO - mozversion application_changeset: 348a56aaff85a04577c394f7c8e5e25125686c8d 14:18:57 INFO - mozversion application_display_name: Nightly 14:18:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:57 INFO - mozversion application_name: Firefox 14:18:57 INFO - mozversion application_remotingname: firefox 14:18:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:18:57 INFO - mozversion application_vendor: Mozilla 14:18:57 INFO - mozversion application_version: 47.0a1 14:18:57 INFO - mozversion platform_buildid: 20160210113059 14:18:57 INFO - mozversion platform_changeset: 348a56aaff85a04577c394f7c8e5e25125686c8d 14:18:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:18:57 INFO - mozversion platform_version: 47.0a1 14:18:57 INFO - using testdate: 1455142737 14:18:57 INFO - actual date: 1455142737 14:18:57 INFO - starting webserver on 'localhost:57796' 14:18:57 INFO - SUITE-START | Running 2 tests 14:18:57 INFO - TEST-START | dromaeo_css 14:18:57 INFO - operating with platform_type : linux_ 14:18:57 INFO - Initialising browser for dromaeo_css test... 14:18:57 INFO - TEST-INFO | started process 5897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFbm7IH/profile http://localhost:57796/getInfo.html) 14:19:01 INFO - PROCESS | 5897 | __metrics Screen width/height:1600/1200 14:19:01 INFO - PROCESS | 5897 | colorDepth:24 14:19:01 INFO - PROCESS | 5897 | Browser inner width/height: 1024/697 14:19:01 INFO - PROCESS | 5897 | __metrics 14:19:02 INFO - PROCESS | 5897 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:02 INFO - TEST-INFO | 5897: exit 0 14:19:02 INFO - Browser initialized. 14:19:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:02 INFO - TEST-INFO | started process 5991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFbm7IH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:14 INFO - PROCESS | 5991 | RSS: Main: 151269376 14:19:14 INFO - PROCESS | 5991 | 14:20:06 INFO - PROCESS | 5991 | 1455142806134 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:22:14 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57796/tests/dromaeo/cssquery-ext.html) 14:22:15 INFO - PROCESS | 5991 | RSS: Main: 235515904 14:22:15 INFO - PROCESS | 5991 | 14:25:17 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-ext.html (next: http://localhost:57796/tests/dromaeo/cssquery-jquery.html) 14:25:17 INFO - PROCESS | 5991 | RSS: Main: 228040704 14:25:17 INFO - PROCESS | 5991 | 14:28:20 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57796/tests/dromaeo/cssquery-mootools.html) 14:28:20 INFO - PROCESS | 5991 | RSS: Main: 237060096 14:28:20 INFO - PROCESS | 5991 | 14:31:22 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57796/tests/dromaeo/cssquery-prototype.html) 14:31:23 INFO - PROCESS | 5991 | RSS: Main: 212508672 14:31:23 INFO - PROCESS | 5991 | 14:34:25 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57796/tests/dromaeo/cssquery-yui.html) 14:34:26 INFO - PROCESS | 5991 | RSS: Main: 220463104 14:34:26 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | Cycle 1(1): loaded http://localhost:57796/tests/dromaeo/cssquery-yui.html (next: http://localhost:57796/tests/dromaeo/cssquery-dojo.html) 14:37:29 INFO - PROCESS | 5991 | RSS: Main: 245682176 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | __start_tp_report 14:37:29 INFO - PROCESS | 5991 | _x_x_mozilla_page_load 14:37:29 INFO - PROCESS | 5991 | _x_x_mozilla_page_load_details 14:37:29 INFO - PROCESS | 5991 | |i|pagename|runs| 14:37:29 INFO - PROCESS | 5991 | |0;dojo.html;3121.7034381733733;3187.920301992451;3223.838808059598;3238.6275578308473;3251.122197006809;5040.294358789773;5126.512981266774;5169.457206993263;5173.534381905628;5210.19242017487;5049.091163590552;5146.845594632157;5155.200943853709;5198.402183748861;5227.973860130694;4634.536546345355;4650.162970665279;4665.5567721066445;4713.622910167195;4798.232282834747;4703.15343238217;4707.693999889996;4745.976270118662;4765.166095933215;4795.592374648141;4636.907261854761;4673.088747694201;4711.7879695413785;4753.857384278477;4760.09558183944;4684.461286951976;4699.506551812045;4704.623630109583;4727.2436410174205;4739.668223224376;4666.043461090469;4674.415698037746;4692.741899195543;4695.1548721230165;4727.787249573777;4854.223324268136;4936.851894443136;4984.675996060245;5016.749162541858;5064.164412871909;5439.945600543983;5447.645903016291;5447.992121457543;5448.645838020556;5451.509364157245;5475.342958844964;5477.3427188737205;5498.202760599691;5500.147477141049;5502.752376143083;5108.821191258326;5161.096808058613;5171.844844654629;5229.660072095302;5246.134387826042;5643.238162848045;5672.858178545569;5673.489385955284;5675.971620141873;5693.28833895763;5371.301730774974;5453.209284653783;5459.672419654833;5461.098918678453;5461.617686761968;5453.318335208099;5458.836234912959;5499.560035197254;5514;5558.861028474321;5454.12733962572;5464.316960379952;5464.398916119224;5466.453354664582;5473.452654734495;5383.084875571162;5407.729613519308;5455.208994695747;5465.125579907275;5518.144687573433;4300.440942677432;4327.069680018811;4328.696991210648;4336.718113322687;4373.825046998148;3817.0838998640124;3819.255245227154;3821.197548514843;3840.9423858642144;3855.479510266134;5082.491750824962;5124.180131178993;5142.5628821549835;5162.354705661793;5201.557867581222;5472.534834539029;5483;5496.532794712414;5509.752061157257;5564.165375193672;5100.540951314325;5208.140656791587;5209.635325527177;5211.166213405837;5253.921191182136;4638.072385522909;4690.179218636725;4746.288056791509;4755.714657120584;4772.522747725269;5681;5695.971520142372;5709.0865461525955;5776.56675749312;5780.826575202666;5524.226608274765;5527.143292789624;5528.778848846162;5529.557635389239;5530;5526.41972592888;5580.804671836466;5668.433156684298;5752.884942301214;5765.192872997867;5391.487808658171;5402.59480538969;5403.621746477709;5404.243405923253;5417.729113544228;5489.835304940858;5495.258140151029;5504.752286147213;5509.641873278224;5543.750531226024;5226.294450249167;5352.732363381738;5385.1922211667;5422.6475279106735;5453.10023846061;5388.488093631099;5418.214358918013;5422.864428389322;5423.810166644149;5433.347998240079;5203.219517072318;5311.415744268204;5330.733463326896;5333.893322133613;5386.084365657926;5317.308749862493;5345.118055520796;5376.973115134556;5433.375161856279;5439.537639300704;5250.474952504872;5258.789648414174;5278.577713782965;5279.419263880894;5282.207668849704 14:37:29 INFO - PROCESS | 5991 | |1;ext.html;517.4618396867261;532.7389579106234;536.2706718862347;537.7714471349675;544.3196004993757;27576.31059223518;28085.578716319247;28130.578041329372;35682.10794730133;35863.46204806923;38244.23511529768;38649.61350386495;38707.806460967724;38711.83864484063;38737.41893871594;8391.580420978957;8495.490270583754;8566.443181193203;8581.785455363635;8584.914150858505;7563.924360756377;7745.148033716287;10187.185025197967;10362.171026317876;10421.583136674524;10053.748656283615;10137.695869123938;10140.847887281696;10143.847842282372;10157.238207134458;9962.950185249063;10035.849462258071;10051.095401413835;10057.497125143713;10057.497125143713;9778.266630002707;9927.255455840841;9930.45382503962;9934.602615895428;9937.75155621108;35534.82232588846;35990.64009359899;39085;39281.60718392808;39352.212955740724;3233.288676491192;3299.686529779667;3314.05549418417;3515.701165400944;3529.0824385659657;29769.25576860574;30041.399172016438;30458.69541304603;30462.39075218483;30585.23536911595;3873.4189871519216;3886.844526218948;3980.7014473914574;3984.721069525134;4083.6528895043957;273975;274192;274805;275609.62195189093;276903;56359.43640563624;57936.42063579395;58174;58174.41825581775;60190.69904650449;60110;60150;60510.39489605048;60600.39399605947;60613.69693151506;15439.768403473958;15951.042937423792;15961.44134955271;15961.680766384607;15979.60050998711;11900.88099119015;12086.274823510617;12105.152639315163;12134.089943254292;12140.45367958444;20015.399538013884;20121.798782012283;20220.292289769786;20383.4904127398;20438.182472701224;7888.6450109744055;8065.838683226302;8067.435279530377;8079.515229086156;8190.099089100194;947.8151760406655;990.6631745206664;1013.9036791504795;1133.4219548030565;1185.1526158796503;29418.705812941596;29437.85281073581;29770.70229297679;29861;31179.844100779803;1048.2714513413105;1065.9733506662396;1073.1522097543009;1190.934498602585;1195.6101478154808;15340.769888451681;15376.692466150615;15447.382104715685;15466.14936178521;15611.609709757347;365510;372961;374533;374567;376346;52326.73836630869;52652.47347526476;52852.47147528476;52862;52885;1321.8413790345028;1355.9762379403487;1385.2035079829138;1386.2791348498724;1490.5304828978838;28384.290392740346;28898.711012890442;29136.56295155532;29342.559861601665;29533.556996645497;42114;45088.54911450844;45436.77281613571;45586.772066139456;45597.316040260084;279208;279828;281861;282784;284024;29176.27059323534;29474;29769.702302976693;29777.25556861096;29891.252718682208;37595.81202093972;38630.42054369243;38793.15063721426;39026.219475610895;39310.41034384429;35260.294794104484;35879.641203588675;36099.27801443904;36336.636633634385;36670.816645917665;35604.46593301155;36068.4589731149;36115.458268125476;36288.4556731644;36354.818225908704;36852.81573592115;39829;40041;40097.39853902252;40158;27880.721192787812;30544.389112218076;30884.0734777957;30941.8452907743;30978.225544361572;24162.275131746075;25134.24597262085;25864.353391165372;25955.870220648776;26102.73897261003 14:37:29 INFO - PROCESS | 5991 | |2;jquery.html;352.6445867570071;359.3567514149672;360.5943313772003;361.20715030508035;361.50293346648357;13557.25435101069;13844.723105537883;16265.268062937166;16935.745963810554;17450.825491745094;15534.300956456958;15588.220588970535;16039.599010024755;16089.597760056004;16102.436414725487;5268.31511903453;5431.131019036935;5432.13085906255;5434.945650543504;5438.91841622376;4007.2185923744883;5306.310179676637;5346.786128554872;5800.361960184377;6011.57918945674;5806.59353845231;5889;5940.138679891435;5941.2276404067625;5943.316518600352;5248.763805628756;5250.894982100336;5252.579793616521;5303.833156705518;5306.867328316785;4698.060387922429;4699.976500117512;4720.244760838284;4760.166970780099;4760.452547956995;19672.409827705193;19687.507812304808;20097;20279.08744106519;20553.69169462459;2198.6701994700925;2337.3572267626537;2607.973920260792;2818.0841226601437;2841.8863245470156;12544.096440849617;12577.811332830015;12728.61814145577;12731.172473789175;12839.486420543168;1831.423101722953;1845.9261629534803;1878.4176905159309;1912.2733361322748;1945.8443324534003;57097.42902570963;58582.41417585855;59516;60122.398776012116;60332;9603.087706667995;9708.514574271258;9911.306208565331;9915.30592858493;9925.801483970281;13069.215847049207;13126.474941002252;13127;13145;13149.145305555108;7772.961135194288;7793.766187014398;7822.647980840876;7866.881996770053;7890.250426209501;7758.107817601048;7769.339606133429;7798.337141342936;7799.181085986003;7800.45396822217;5986.790462333797;6041.124037014608;6054.939450605526;6074.483668888194;6117.663528505975;1660.8588269996944;1726.3181043487753;1754.5701303180801;1796.5059608607476;1804.2151664026192;921.3964853021148;989.8812142542942;1005.9144972677258;1061.4851796878509;1124.970651853545;13895.722085558233;16121.919390402973;17411.912940435217;17551.034693092002;17634.647307053787;865.3682811547606;935.9578818953163;948.6252930092713;986.0977205856705;1019.8781340525363;9782;10111;10121.291509594257;10138.391696498235;10163.745906352253;501270;501866;534353;538058;547491;69282.65358673174;73302.63348683223;74421.25578744143;74584.25415745773;75534.62232688801;1176.2178151529308;1181.8404515390484;1225.6323103069044;1228.668259569911;1243.30996297056;15343.61640958985;15406.383744650537;15436;15573.37706491773;15936;25416.110436134648;33879.830600846835;34478.65521344754;34725.82637086798;35504.64495355013;46335.30497042614;46924.530754692016;47077.29384059173;47205.29192062053;47570;7434.739784107746;7625.351845093007;7765.301122898966;7785.065792104983;7831.647575858986;7615.666171322692;9842.507874606097;10375.84436233442;10740.73148171302;10744.892551074388;9654.806903862023;9862.358946668444;10024.649137280161;10058.446785426871;10266.486675666038;9896.851547226941;9958.800823983625;9964.800703986024;10293.279470436997;10337.37975721459;7093.929060709534;9529;10008.199344052604;10072.395656260647;10155.89844101579;7555.357794587521;7567.281108294703;7589.316961473494;7597.6581053851605;7615.238476152341;8425.70510032146;10415.270931034755;10452.111570516592;10615.840762388416;10643.840342395026 14:37:29 INFO - PROCESS | 5991 | |3;mootools.html;1310.1353106949416;1440.539027511196;1445.2340259662378;1577.881658875584;1753.8684598655095;6899.551529150608;7379.704811807528;7416.295451932065;7440.553566785983;7529.661165247563;7504.924950750491;7512.399008079355;7589.620518974043;7597.8480430391355;7614.048243969504;1992.282778199847;2031.6343058249508;2310.919117830872;2338.1348900906687;2342.8008619267384;2305.6080466320764;2364.5034542746043;2366.6213405855065;2367.112332875172;2367.490989437271;2226.3988723044768;2279.6010698127843;2285.3029825903095;2286.9542609147807;2287.1537531113513;1972.1026932745638;2221.8111460525874;2257.4582100295893;2286.7141607299086;2293.724753029647;2266.5466906618576;2268.1494439585153;2296.8966396512196;2304.585174668559;2304.6543018547354;7495.475316727831;7515.361194298491;7516.661750221253;7563.130240022413;7571.545707257527;4575.862724118282;4715.504871988426;4719.62243020561;4733.3846599942135;4733.5503127202865;3144.606924134483;3156.6369867465305;3167.33485967947;3213.3252017076443;3214.067920303109;1009.7122320138725;1027.275770581738;1039.864817573718;1058.0636137018794;1059.814532456817;10442.425666588335;10518.631847885365;10534.473276336152;10547.050765431148;10551.683449496528;4186.665066794649;4253.957460425356;4317.827286908551;4357.782110894443;4362.0185458271635;8856.335774816915;8880;8880.8667869982;8912.376133670581;8927.642894284156;4753.453352864396;4785.306130611111;4787;4789.521047895182;4796.328514008042;4301.451477468109;4305.375720520569;4306.246406878784;4311.374850646639;4312.805923733439;3586.8744593939086;3607.603163651996;3639.9272014560092;3644.2711457708565;3742.7567208131927;1157.4617802721775;1164.796160671879;1166.2710805746408;1171.1977295552574;1180.7756526259984;963.8843338799389;977.3695966101825;979.5347210075299;1085.8914108589236;1363.6727185475415;6702.162229721285;6960.9303906961295;6962.965185174143;6968.198657154492;7019.122609673791;609.8231512861221;614.7940439952666;620.0389396435507;631.3875540725489;634.1185751804994;5603.915941260884;5672.319321681424;5674.829755107354;5713.171590119493;5725.828225153252;8847.823043539092;9190.724278271662;9198.356115071882;9212.677556285498;9298.628054877729;9070.410423322463;9190.035046320174;9201.723948281562;9206.217471514863;9321.161095501302;7010.789676309719;7156.892646610305;7165.068541089625;7190.137183538009;7223.819404514929;7073.717051318095;7100.396466300215;7152.034475345969;7164.749233776793;7172.856542869218;7961.243681850215;7964.2433968772875;8071.394645401501;8220.177982201732;8247.505149690798;8174.754757357289;8267.338612911073;8283.83432331338;8449.915500844912;8457.323414126979;6817.761378351734;7000.719971201095;7049.682764275723;7051.964740176266;7059.752908648173;7400.444966627417;7400.555966642019;7409.925900740924;7412.295831895961;7467.1039475263315;6774;6898.517103802686;7012.333828286304;7041.3310735480045;7090.822729431599;6723.865522689421;6884.621345826027;6934.271901450275;6945.583265004116;7009.824754381181;6148.78479253224;6669.46644268467;6727.192736871411;6891.138607674041;6902.689378978059;5931.792387266598;5952.5833191676165;5963.105534169909;6008;6011.519078473624;6143.784967526115;6202.317745047951;6223.37766223374;6224.657643829632;6224.751009959551 14:37:29 INFO - PROCESS | 5991 | |4;prototype.html;320.1116900600834;332.81029813006563;333.7380156577087;340.25823704324563;340.558976125917;5678.943210567893;5815.534757219423;5837.708114594275;5914.172015917775;5944.821655350335;5673.943260567393;5770;5800.419958004198;5807.070868661015;5813.157092221625;4537.4328208973875;4538.818447262105;4544.681872268942;4545.590896819285;4548.113117942003;4365.869023929287;4417.955820441786;4491.124230775;4509.278515437531;4552.226121559343;4480.484744254403;4481.596656300949;4483.932741008887;4495;4503.211937910869;4507.481639611421;4511.458624965009;4511.6165125964335;4513.571210734975;4519.209138400784;3981.7810020448865;3984.9601503984877;3988.66096381805;3997.320455522568;4002.6197511236387;5335.039692855285;5502;5503.504684578367;5514.035043867348;5539.196816461631;5167.018266529385;5167.7674504647;5168.7415629218385;5170.715610641413;5171.146760784503;5976.223090998186;6243.563980284514;6246;6248.9062664060075;6268.310485846553;4372;4427.335899615051;4435.556444355571;4437.800298986554;4441.444819397575;6412.454941329993;6507.6420796856155;6519.608823470559;6526.738930442777;6527.771527996545;4577.427821522309;4578.35902973584;4578.931316030262;4582.747948862778;4583.770811459413;4546.636269098464;4617.976910115428;4641.118187544424;4644.117617652635;4652.906941861143;5296.576273898079;5297.5232229099565;5302.072137375943;5302.5683065572075;5304;6286.277078135981;6288.339724328971;6289.654069026156;6296.496280297565;6301.054841773679;1619.0852168524746;1646.0864220357578;1646.1769115442278;1646.1933652510183;1649.6205872649357;1111.3554138599593;1112.8275117356823;1124.2748427264369;1138.2885696439726;1152.464104191555;5982.7008649568215;5989.520838332923;5999.070144127667;6002.249718785152;6003.909941350883;6400.935990640127;6417.069524918954;6444.484441244689;6444.709988050549;6446.516511261674;5891.911621325684;5997.190379298739;6041.184440100618;6049.697515124314;6051.788187413419;3461.238527523941;3477.2871561329866;3486.6861982421706;3487.4245749451056;3491.9825400872833;6770.661466926634;6775.085363475868;6775.559588626822;6778.91537354021;6780.355866192704;6475.4819614430735;6581.210254769362;6584.209894812558;6590.275069742324;6594.472442204612;6631.502637302222;6711.127553418122;6752.932470675329;6763.6618169092335;6770.086038384755;6226.875462490815;6310.242770867525;6400.39196276353;6414.93585064162;6419.422251997343;6389.594289256356;6423.362042679274;6436.581622194542;6447.0651755494255;6447.516436267392;6794.660266986532;6800.591964482147;6801.965990170215;6804.795856124324;6817.420519255918;4479.46246450428;4504.752238626907;4554.954450455453;4561.977190114028;4571.26859702446;6448.258450278278;6451.48388128958;6464.644444555594;6476.190476190476;6483.805485835433;6265.310815810166;6293.622382657055;6294.433500984934;6304.275008373912;6323.20959880015;6170.6914654268;6288.5598008138995;6289.685515724287;6289.710609325169;6292.835825372321;6190.164327815687;6199.1011303361665;6199.690015499117;6200.441960223601;6205;6318.494520438262;6334.113224148715;6337.176167098432;6344.333844946399;6354.968225158845;6080.695965201634;6186.288576813724;6188.535859810622;6189.690515474298;6197.380261973766 14:37:29 INFO - PROCESS | 5991 | |5;yui.html;707.9929200707993;771.672039383262;818.9344852411807;819.9412906114734;833.5415521463198;12433.129680922328;12556.623301300975;12582.182158159712;12583.182093163938;12603;12544.937275313634;12863.228206307627;12993.2204067756;13054.543090991818;13057;691.495208497797;699.7445932234749;816.0696805641574;817.1868990354606;842.1241908415241;831.3972370031709;839.7900524868783;840.9621567029468;841.0706169682504;842.0400743152811;873.3100850328233;875.7460336502406;876.5529579914225;877.1886005444937;881.1056777370974;713.4007433755644;850.2560259772699;860.1484530315006;863.1713554987219;865.0570877743227;633.882731694638;634.8857205702972;638.8498702804884;638.8913884639576;639.3542522052713;13229.140105893086;13251.337433128401;13290.601281961557;13297.202167869862;13304.334783260798;12867.970562354989;12920.160189587647;13254.271015094166;13314.600561983156;13320.400581973738;10328.225383096298;10545.947270263676;10630;10705.83941240882;10711.089557387631;3235.5955505561806;3301.240714635623;3334.1831251343333;3348.2131699050706;3397.6602339766073;47951.5204847954;49716.50283497155;49759;49792.50207497951;49810.750946245396;9690.079442452956;9745.805083898424;10039.799204015879;10150.03574660406;10177.287589868638;18934.147963341406;18968.24127034903;18994;19000.33498827562;19029.714554281698;7783.494072885244;7821.92178078212;7844.37245020397;7927.762167134995;8019.518828870287;4199.328107502785;4207.8316867325575;4234.216669916075;4246;4268.167707297047;3131.7181453668823;3131.7807753457496;3139.984300078485;3159.873605055818;3162.6995435433596;567.5005994724615;572.2389222334285;578.7424596054799;587.6679675983056;600.0968542343832;577.7544543568966;627.3193584960278;704.3695892176473;707.3307440861499;719.597025665629;7646;7957.840843183104;8088.676452941934;8595.699150529701;8753.912460875437;591.8837321502294;621.0901029990995;637.9537558404221;651.6155468273741;652.4063102576632;3802.5056742623833;3863.208042351311;3884.9028774280305;3963.2667956428154;4116.485439320085;55922.72038639781;58546.12180817291;58589.707051465324;58593;58678.413215867295;50674.74662626737;50931.23603145956;51043.23435148476;51937;51949.480505194464;44736.55263447454;45274;45471.31793023041;45597.54402456;45647;8064;8165;8401.117882622237;8434.915650843659;8528.616212270339;33419.33161336711;33420.498692520116;34077.48883766696;34150.82924585361;34910.301793963474;40062.599374007055;40214.79892600518;41619.7919010403;42580;42594.361084583135;10803.45982700846;11080.224384293344;11131.443427828739;11231.382273974683;11324.150688698215;12541;12550.811737823757;12586.118971672262;12811.167274127152;13190.538331158363;11735.295882247092;12105.455254513745;12108;12505.562305319634;12643.747125057631;11653.126015549038;11715.121365897421;11818.290902545874;11920.582779602672;12266.815997760219;11380.146489013523;11638.592649257236;11702.88297117052;11831.053515718893;12209.145359824726;9619.086942895456;9795.706128816148;9811.509424528602;9909.405435673883;10345.585956634442;9226.723198304062;9538.332316737762;9788.265880059167;9894.455804930798;10380.688579342632 14:37:29 INFO - PROCESS | 5991 | __end_tp_report 14:37:29 INFO - PROCESS | 5991 | __start_cc_report 14:37:29 INFO - PROCESS | 5991 | _x_x_mozilla_cycle_collect,699 14:37:29 INFO - PROCESS | 5991 | __end_cc_report 14:37:29 INFO - PROCESS | 5991 | __startTimestamp1455143849256__endTimestamp 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | ------- Summary: start ------- 14:37:29 INFO - PROCESS | 5991 | Number of tests: 6 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#0] dojo.html Cycles:165 Average:5120.32 Median:5311.42 stddev:539.77 (10.2%) stddev-sans-first:518.15 14:37:29 INFO - PROCESS | 5991 | Values: 3121.7 3187.9 3223.8 3238.6 3251.1 5040.3 5126.5 5169.5 5173.5 5210.2 5049.1 5146.8 5155.2 5198.4 5228.0 4634.5 4650.2 4665.6 4713.6 4798.2 4703.2 4707.7 4746.0 4765.2 4795.6 4636.9 4673.1 4711.8 4753.9 4760.1 4684.5 4699.5 4704.6 4727.2 4739.7 4666.0 4674.4 4692.7 4695.2 4727.8 4854.2 4936.9 4984.7 5016.7 5064.2 5439.9 5447.6 5448.0 5448.6 5451.5 5475.3 5477.3 5498.2 5500.1 5502.8 5108.8 5161.1 5171.8 5229.7 5246.1 5643.2 5672.9 5673.5 5676.0 5693.3 5371.3 5453.2 5459.7 5461.1 5461.6 5453.3 5458.8 5499.6 5514.0 5558.9 5454.1 5464.3 5464.4 5466.5 5473.5 5383.1 5407.7 5455.2 5465.1 5518.1 4300.4 4327.1 4328.7 4336.7 4373.8 3817.1 3819.3 3821.2 3840.9 3855.5 5082.5 5124.2 5142.6 5162.4 5201.6 5472.5 5483.0 5496.5 5509.8 5564.2 5100.5 5208.1 5209.6 5211.2 5253.9 4638.1 4690.2 4746.3 4755.7 4772.5 5681.0 5696.0 5709.1 5776.6 5780.8 5524.2 5527.1 5528.8 5529.6 5530.0 5526.4 5580.8 5668.4 5752.9 5765.2 5391.5 5402.6 5403.6 5404.2 5417.7 5489.8 5495.3 5504.8 5509.6 5543.8 5226.3 5352.7 5385.2 5422.6 5453.1 5388.5 5418.2 5422.9 5423.8 5433.3 5203.2 5311.4 5330.7 5333.9 5386.1 5317.3 5345.1 5377.0 5433.4 5439.5 5250.5 5258.8 5278.6 5279.4 5282.2 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#1] ext.html Cycles:180 Average:47464.04 Median:3414.88 stddev:82031.61 (2402.2%) stddev-sans-first:82186.00 14:37:29 INFO - PROCESS | 5991 | Values: 517.5 532.7 536.3 537.8 544.3 27576.3 28085.6 28130.6 35682.1 35863.5 38244.2 38649.6 38707.8 38711.8 38737.4 8391.6 8495.5 8566.4 8581.8 8584.9 7563.9 7745.1 10187.2 10362.2 10421.6 10053.7 10137.7 10140.8 10143.8 10157.2 9963.0 10035.8 10051.1 10057.5 10057.5 9778.3 9927.3 9930.5 9934.6 9937.8 35534.8 35990.6 39085.0 39281.6 39352.2 3233.3 3299.7 3314.1 3515.7 3529.1 29769.3 30041.4 30458.7 30462.4 30585.2 3873.4 3886.8 3980.7 3984.7 4083.7 273975.0 274192.0 274805.0 275609.6 276903.0 56359.4 57936.4 58174.0 58174.4 60190.7 60110.0 60150.0 60510.4 60600.4 60613.7 15439.8 15951.0 15961.4 15961.7 15979.6 11900.9 12086.3 12105.2 12134.1 12140.5 20015.4 20121.8 20220.3 20383.5 20438.2 7888.6 8065.8 8067.4 8079.5 8190.1 947.8 990.7 1013.9 1133.4 1185.2 29418.7 29437.9 29770.7 29861.0 31179.8 1048.3 1066.0 1073.2 1190.9 1195.6 15340.8 15376.7 15447.4 15466.1 15611.6 365510.0 372961.0 374533.0 374567.0 376346.0 52326.7 52652.5 52852.5 52862.0 52885.0 1321.8 1356.0 1385.2 1386.3 1490.5 28384.3 28898.7 29136.6 29342.6 29533.6 42114.0 45088.5 45436.8 45586.8 45597.3 279208.0 279828.0 281861.0 282784.0 284024.0 29176.3 29474.0 29769.7 29777.3 29891.3 37595.8 38630.4 38793.2 39026.2 39310.4 35260.3 35879.6 36099.3 36336.6 36670.8 35604.5 36068.5 36115.5 36288.5 36354.8 36852.8 39829.0 40041.0 40097.4 40158.0 27880.7 30544.4 30884.1 30941.8 30978.2 24162.3 25134.2 25864.4 25955.9 26102.7 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#2] jquery.html Cycles:180 Average:27471.07 Median:25811.30 stddev:85790.34 (332.4%) stddev-sans-first:86006.83 14:37:29 INFO - PROCESS | 5991 | Values: 352.6 359.4 360.6 361.2 361.5 13557.3 13844.7 16265.3 16935.7 17450.8 15534.3 15588.2 16039.6 16089.6 16102.4 5268.3 5431.1 5432.1 5434.9 5438.9 4007.2 5306.3 5346.8 5800.4 6011.6 5806.6 5889.0 5940.1 5941.2 5943.3 5248.8 5250.9 5252.6 5303.8 5306.9 4698.1 4700.0 4720.2 4760.2 4760.5 19672.4 19687.5 20097.0 20279.1 20553.7 2198.7 2337.4 2608.0 2818.1 2841.9 12544.1 12577.8 12728.6 12731.2 12839.5 1831.4 1845.9 1878.4 1912.3 1945.8 57097.4 58582.4 59516.0 60122.4 60332.0 9603.1 9708.5 9911.3 9915.3 9925.8 13069.2 13126.5 13127.0 13145.0 13149.1 7773.0 7793.8 7822.6 7866.9 7890.3 7758.1 7769.3 7798.3 7799.2 7800.5 5986.8 6041.1 6054.9 6074.5 6117.7 1660.9 1726.3 1754.6 1796.5 1804.2 921.4 989.9 1005.9 1061.5 1125.0 13895.7 16121.9 17411.9 17551.0 17634.6 865.4 936.0 948.6 986.1 1019.9 9782.0 10111.0 10121.3 10138.4 10163.7 501270.0 501866.0 534353.0 538058.0 547491.0 69282.7 73302.6 74421.3 74584.3 75534.6 1176.2 1181.8 1225.6 1228.7 1243.3 15343.6 15406.4 15436.0 15573.4 15936.0 25416.1 33879.8 34478.7 34725.8 35504.6 46335.3 46924.5 47077.3 47205.3 47570.0 7434.7 7625.4 7765.3 7785.1 7831.6 7615.7 9842.5 10375.8 10740.7 10744.9 9654.8 9862.4 10024.6 10058.4 10266.5 9896.9 9958.8 9964.8 10293.3 10337.4 7093.9 9529.0 10008.2 10072.4 10155.9 7555.4 7567.3 7589.3 7597.7 7615.2 8425.7 10415.3 10452.1 10615.8 10643.8 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#3] mootools.html Cycles:180 Average:5340.27 Median:3384.41 stddev:2758.05 (81.5%) stddev-sans-first:2749.15 14:37:29 INFO - PROCESS | 5991 | Values: 1310.1 1440.5 1445.2 1577.9 1753.9 6899.6 7379.7 7416.3 7440.6 7529.7 7504.9 7512.4 7589.6 7597.8 7614.0 1992.3 2031.6 2310.9 2338.1 2342.8 2305.6 2364.5 2366.6 2367.1 2367.5 2226.4 2279.6 2285.3 2287.0 2287.2 1972.1 2221.8 2257.5 2286.7 2293.7 2266.5 2268.1 2296.9 2304.6 2304.7 7495.5 7515.4 7516.7 7563.1 7571.5 4575.9 4715.5 4719.6 4733.4 4733.6 3144.6 3156.6 3167.3 3213.3 3214.1 1009.7 1027.3 1039.9 1058.1 1059.8 10442.4 10518.6 10534.5 10547.1 10551.7 4186.7 4254.0 4317.8 4357.8 4362.0 8856.3 8880.0 8880.9 8912.4 8927.6 4753.5 4785.3 4787.0 4789.5 4796.3 4301.5 4305.4 4306.2 4311.4 4312.8 3586.9 3607.6 3639.9 3644.3 3742.8 1157.5 1164.8 1166.3 1171.2 1180.8 963.9 977.4 979.5 1085.9 1363.7 6702.2 6960.9 6963.0 6968.2 7019.1 609.8 614.8 620.0 631.4 634.1 5603.9 5672.3 5674.8 5713.2 5725.8 8847.8 9190.7 9198.4 9212.7 9298.6 9070.4 9190.0 9201.7 9206.2 9321.2 7010.8 7156.9 7165.1 7190.1 7223.8 7073.7 7100.4 7152.0 7164.7 7172.9 7961.2 7964.2 8071.4 8220.2 8247.5 8174.8 8267.3 8283.8 8449.9 8457.3 6817.8 7000.7 7049.7 7052.0 7059.8 7400.4 7400.6 7409.9 7412.3 7467.1 6774.0 6898.5 7012.3 7041.3 7090.8 6723.9 6884.6 6934.3 6945.6 7009.8 6148.8 6669.5 6727.2 6891.1 6902.7 5931.8 5952.6 5963.1 6008.0 6011.5 6143.8 6202.3 6223.4 6224.7 6224.8 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#4] prototype.html Cycles:180 Average:5253.09 Median:5960.52 stddev:1565.80 (26.3%) stddev-sans-first:1525.79 14:37:29 INFO - PROCESS | 5991 | Values: 320.1 332.8 333.7 340.3 340.6 5678.9 5815.5 5837.7 5914.2 5944.8 5673.9 5770.0 5800.4 5807.1 5813.2 4537.4 4538.8 4544.7 4545.6 4548.1 4365.9 4418.0 4491.1 4509.3 4552.2 4480.5 4481.6 4483.9 4495.0 4503.2 4507.5 4511.5 4511.6 4513.6 4519.2 3981.8 3985.0 3988.7 3997.3 4002.6 5335.0 5502.0 5503.5 5514.0 5539.2 5167.0 5167.8 5168.7 5170.7 5171.1 5976.2 6243.6 6246.0 6248.9 6268.3 4372.0 4427.3 4435.6 4437.8 4441.4 6412.5 6507.6 6519.6 6526.7 6527.8 4577.4 4578.4 4578.9 4582.7 4583.8 4546.6 4618.0 4641.1 4644.1 4652.9 5296.6 5297.5 5302.1 5302.6 5304.0 6286.3 6288.3 6289.7 6296.5 6301.1 1619.1 1646.1 1646.2 1646.2 1649.6 1111.4 1112.8 1124.3 1138.3 1152.5 5982.7 5989.5 5999.1 6002.2 6003.9 6400.9 6417.1 6444.5 6444.7 6446.5 5891.9 5997.2 6041.2 6049.7 6051.8 3461.2 3477.3 3486.7 3487.4 3492.0 6770.7 6775.1 6775.6 6778.9 6780.4 6475.5 6581.2 6584.2 6590.3 6594.5 6631.5 6711.1 6752.9 6763.7 6770.1 6226.9 6310.2 6400.4 6414.9 6419.4 6389.6 6423.4 6436.6 6447.1 6447.5 6794.7 6800.6 6802.0 6804.8 6817.4 4479.5 4504.8 4555.0 4562.0 4571.3 6448.3 6451.5 6464.6 6476.2 6483.8 6265.3 6293.6 6294.4 6304.3 6323.2 6170.7 6288.6 6289.7 6289.7 6292.8 6190.2 6199.1 6199.7 6200.4 6205.0 6318.5 6334.1 6337.2 6344.3 6355.0 6080.7 6186.3 6188.5 6189.7 6197.4 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - PROCESS | 5991 | [#5] yui.html Cycles:180 Average:13776.29 Median:45005.28 stddev:15815.01 (35.1%) stddev-sans-first:15828.93 14:37:29 INFO - PROCESS | 5991 | Values: 708.0 771.7 818.9 819.9 833.5 12433.1 12556.6 12582.2 12583.2 12603.0 12544.9 12863.2 12993.2 13054.5 13057.0 691.5 699.7 816.1 817.2 842.1 831.4 839.8 841.0 841.1 842.0 873.3 875.7 876.6 877.2 881.1 713.4 850.3 860.1 863.2 865.1 633.9 634.9 638.8 638.9 639.4 13229.1 13251.3 13290.6 13297.2 13304.3 12868.0 12920.2 13254.3 13314.6 13320.4 10328.2 10545.9 10630.0 10705.8 10711.1 3235.6 3301.2 3334.2 3348.2 3397.7 47951.5 49716.5 49759.0 49792.5 49810.8 9690.1 9745.8 10039.8 10150.0 10177.3 18934.1 18968.2 18994.0 19000.3 19029.7 7783.5 7821.9 7844.4 7927.8 8019.5 4199.3 4207.8 4234.2 4246.0 4268.2 3131.7 3131.8 3140.0 3159.9 3162.7 567.5 572.2 578.7 587.7 600.1 577.8 627.3 704.4 707.3 719.6 7646.0 7957.8 8088.7 8595.7 8753.9 591.9 621.1 638.0 651.6 652.4 3802.5 3863.2 3884.9 3963.3 4116.5 55922.7 58546.1 58589.7 58593.0 58678.4 50674.7 50931.2 51043.2 51937.0 51949.5 44736.6 45274.0 45471.3 45597.5 45647.0 8064.0 8165.0 8401.1 8434.9 8528.6 33419.3 33420.5 34077.5 34150.8 34910.3 40062.6 40214.8 41619.8 42580.0 42594.4 10803.5 11080.2 11131.4 11231.4 11324.2 12541.0 12550.8 12586.1 12811.2 13190.5 11735.3 12105.5 12108.0 12505.6 12643.7 11653.1 11715.1 11818.3 11920.6 12266.8 11380.1 11638.6 11702.9 11831.1 12209.1 9619.1 9795.7 9811.5 9909.4 10345.6 9226.7 9538.3 9788.3 9894.5 10380.7 14:37:29 INFO - PROCESS | 5991 | -------- Summary: end -------- 14:37:29 INFO - PROCESS | 5991 | 14:37:29 INFO - TEST-INFO | 5991: exit 0 14:37:29 INFO - TEST-OK | dromaeo_css | took 1112577ms 14:37:29 INFO - TEST-START | kraken 14:37:29 INFO - operating with platform_type : linux_ 14:37:29 INFO - Initialising browser for kraken test... 14:37:29 INFO - TEST-INFO | started process 6169 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeMwpAs/profile http://localhost:57796/getInfo.html) 14:37:33 INFO - PROCESS | 6169 | __metrics Screen width/height:1600/1200 14:37:33 INFO - PROCESS | 6169 | colorDepth:24 14:37:33 INFO - PROCESS | 6169 | Browser inner width/height: 1024/697 14:37:33 INFO - PROCESS | 6169 | __metrics 14:37:33 INFO - PROCESS | 6169 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:34 INFO - TEST-INFO | 6169: exit 0 14:37:34 INFO - Browser initialized. 14:37:34 INFO - Running cycle 1/1 for kraken test... 14:37:34 INFO - TEST-INFO | started process 6255 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeMwpAs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:46 INFO - PROCESS | 6255 | RSS: Main: 150945792 14:37:46 INFO - PROCESS | 6255 | 14:37:49 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57796/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:49 INFO - PROCESS | 6255 | RSS: Main: 192106496 14:37:49 INFO - PROCESS | 6255 | 14:37:52 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57796/tests/kraken/driver.html?testName=audio-dft) 14:37:52 INFO - PROCESS | 6255 | RSS: Main: 180797440 14:37:52 INFO - PROCESS | 6255 | 14:37:55 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57796/tests/kraken/driver.html?testName=audio-fft) 14:37:56 INFO - PROCESS | 6255 | RSS: Main: 166023168 14:37:56 INFO - PROCESS | 6255 | 14:37:58 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57796/tests/kraken/driver.html?testName=audio-oscillator) 14:37:59 INFO - PROCESS | 6255 | RSS: Main: 168271872 14:37:59 INFO - PROCESS | 6255 | 14:38:01 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57796/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:01 INFO - PROCESS | 6255 | RSS: Main: 169373696 14:38:01 INFO - PROCESS | 6255 | 14:38:04 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57796/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:05 INFO - PROCESS | 6255 | RSS: Main: 171130880 14:38:05 INFO - PROCESS | 6255 | 14:38:08 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57796/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:09 INFO - PROCESS | 6255 | RSS: Main: 171352064 14:38:09 INFO - PROCESS | 6255 | 14:38:12 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57796/tests/kraken/driver.html?testName=json-parse-financial) 14:38:12 INFO - PROCESS | 6255 | RSS: Main: 172195840 14:38:12 INFO - PROCESS | 6255 | 14:38:14 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57796/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:14 INFO - PROCESS | 6255 | RSS: Main: 180682752 14:38:14 INFO - PROCESS | 6255 | 14:38:16 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:17 INFO - PROCESS | 6255 | RSS: Main: 178606080 14:38:17 INFO - PROCESS | 6255 | 14:38:19 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:20 INFO - PROCESS | 6255 | RSS: Main: 190689280 14:38:20 INFO - PROCESS | 6255 | 14:38:22 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:23 INFO - PROCESS | 6255 | RSS: Main: 196214784 14:38:23 INFO - PROCESS | 6255 | 14:38:25 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:26 INFO - PROCESS | 6255 | RSS: Main: 194416640 14:38:26 INFO - PROCESS | 6255 | 14:38:27 INFO - PROCESS | 6255 | Cycle 1(1): loaded http://localhost:57796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57796/tests/kraken/driver.html?testName=ai-astar) 14:38:28 INFO - PROCESS | 6255 | RSS: Main: 254803968 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | __start_tp_report 14:38:28 INFO - PROCESS | 6255 | _x_x_mozilla_page_load 14:38:28 INFO - PROCESS | 6255 | _x_x_mozilla_page_load_details 14:38:28 INFO - PROCESS | 6255 | |i|pagename|runs| 14:38:28 INFO - PROCESS | 6255 | |0;ai-astar;111;113;107;112;113;112;102;113;113;113 14:38:28 INFO - PROCESS | 6255 | |1;audio-beat-detection;157;127;158;166;128;150;152;127;173;125 14:38:28 INFO - PROCESS | 6255 | |2;audio-dft;163;161;161;163;162;161;162;166;161;162 14:38:28 INFO - PROCESS | 6255 | |3;audio-fft;76;74;105;93;74;78;73;120;94;73 14:38:28 INFO - PROCESS | 6255 | |4;audio-oscillator;97;96;156;96;96;97;140;97;96;137 14:38:28 INFO - PROCESS | 6255 | |5;imaging-gaussian-blur;119;115;115;114;115;115;116;115;115;115 14:38:28 INFO - PROCESS | 6255 | |6;imaging-darkroom;146;147;147;147;146;147;145;146;148;145 14:38:28 INFO - PROCESS | 6255 | |7;imaging-desaturate;96;95;96;95;96;96;96;96;95;96 14:38:28 INFO - PROCESS | 6255 | |8;json-parse-financial;56;55;56;56;55;55;54;65;54;54 14:38:28 INFO - PROCESS | 6255 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;67;66;67 14:38:28 INFO - PROCESS | 6255 | |10;stanford-crypto-aes;85;86;86;87;85;85;86;86;86;86 14:38:28 INFO - PROCESS | 6255 | |11;stanford-crypto-ccm;119;115;114;115;123;115;126;115;121;116 14:38:28 INFO - PROCESS | 6255 | |12;stanford-crypto-pbkdf2;154;140;151;150;163;144;150;150;153;153 14:38:28 INFO - PROCESS | 6255 | |13;stanford-crypto-sha256-iterative;68;69;71;68;68;68;70;70;68;70 14:38:28 INFO - PROCESS | 6255 | __end_tp_report 14:38:28 INFO - PROCESS | 6255 | __start_cc_report 14:38:28 INFO - PROCESS | 6255 | _x_x_mozilla_cycle_collect,967 14:38:28 INFO - PROCESS | 6255 | __end_cc_report 14:38:28 INFO - PROCESS | 6255 | __startTimestamp1455143908153__endTimestamp 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | ------- Summary: start ------- 14:38:28 INFO - PROCESS | 6255 | Number of tests: 14 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:3.63 (3.2%) stddev-sans-first:3.86 14:38:28 INFO - PROCESS | 6255 | Values: 111.0 113.0 107.0 112.0 113.0 112.0 102.0 113.0 113.0 113.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.50 stddev:18.05 (11.7%) stddev-sans-first:18.72 14:38:28 INFO - PROCESS | 6255 | Values: 157.0 127.0 158.0 166.0 128.0 150.0 152.0 127.0 173.0 125.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.62 14:38:28 INFO - PROCESS | 6255 | Values: 163.0 161.0 161.0 163.0 162.0 161.0 162.0 166.0 161.0 162.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#3] audio-fft Cycles:10 Average:86.00 Median:75.00 stddev:16.40 (21.9%) stddev-sans-first:16.99 14:38:28 INFO - PROCESS | 6255 | Values: 76.0 74.0 105.0 93.0 74.0 78.0 73.0 120.0 94.0 73.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:96.00 stddev:23.64 (24.6%) stddev-sans-first:24.54 14:38:28 INFO - PROCESS | 6255 | Values: 97.0 96.0 156.0 96.0 96.0 97.0 140.0 97.0 96.0 137.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 14:38:28 INFO - PROCESS | 6255 | Values: 119.0 115.0 115.0 114.0 115.0 115.0 116.0 115.0 115.0 115.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 14:38:28 INFO - PROCESS | 6255 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 145.0 146.0 148.0 145.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:38:28 INFO - PROCESS | 6255 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.27 (5.9%) stddev-sans-first:3.46 14:38:28 INFO - PROCESS | 6255 | Values: 56.0 55.0 56.0 56.0 55.0 55.0 54.0 65.0 54.0 54.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 14:38:28 INFO - PROCESS | 6255 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:38:28 INFO - PROCESS | 6255 | Values: 85.0 86.0 86.0 87.0 85.0 85.0 86.0 86.0 86.0 86.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.50 stddev:4.15 (3.5%) stddev-sans-first:4.38 14:38:28 INFO - PROCESS | 6255 | Values: 119.0 115.0 114.0 115.0 123.0 115.0 126.0 115.0 121.0 116.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:152.00 stddev:6.09 (4.0%) stddev-sans-first:6.35 14:38:28 INFO - PROCESS | 6255 | Values: 154.0 140.0 151.0 150.0 163.0 144.0 150.0 150.0 153.0 153.0 14:38:28 INFO - PROCESS | 6255 | 14:38:28 INFO - PROCESS | 6255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 14:38:28 INFO - PROCESS | 6255 | Values: 68.0 69.0 71.0 68.0 68.0 68.0 70.0 70.0 68.0 70.0 14:38:28 INFO - PROCESS | 6255 | -------- Summary: end -------- 14:38:28 INFO - PROCESS | 6255 | 14:38:29 INFO - TEST-INFO | 6255: exit 0 14:38:29 INFO - TEST-OK | kraken | took 59225ms 14:38:29 INFO - SUITE-END | took 1171s 14:38:29 INFO - Completed test suite (00:19:31) 14:38:29 INFO - Working with test: dromaeo_css 14:38:29 INFO - Generating results file: dromaeo_css 14:38:29 INFO - Working with test: kraken 14:38:29 INFO - Generating results file: kraken 14:38:29 INFO - javascript benchmark 14:38:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:38:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:38:29 INFO - process_Request line: dromaeo_css 6865.79 graph.html#tests=[[72,201,35]] 14:38:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:38:29 INFO - process_Request line: kraken 1520.10 graph.html#tests=[[232,201,35]] 14:38:29 INFO - RETURN: dromaeo_css: 6865.79 14:38:29 INFO - RETURN: kraken: 1520.10 14:38:29 INFO - javascript benchmark 14:38:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.7034381733733, 3187.920301992451, 3223.838808059598, 3238.6275578308473, 3251.122197006809, 5040.294358789773, 5126.512981266774, 5169.457206993263, 5173.534381905628, 5210.19242017487, 5049.091163590552, 5146.845594632157, 5155.200943853709, 5198.402183748861, 5227.973860130694, 4634.536546345355, 4650.162970665279, 4665.5567721066445, 4713.622910167195, 4798.232282834747, 4703.15343238217, 4707.693999889996, 4745.976270118662, 4765.166095933215, 4795.592374648141, 4636.907261854761, 4673.088747694201, 4711.7879695413785, 4753.857384278477, 4760.09558183944, 4684.461286951976, 4699.506551812045, 4704.623630109583, 4727.2436410174205, 4739.668223224376, 4666.043461090469, 4674.415698037746, 4692.741899195543, 4695.1548721230165, 4727.787249573777, 4854.223324268136, 4936.851894443136, 4984.675996060245, 5016.749162541858, 5064.164412871909, 5439.945600543983, 5447.645903016291, 5447.992121457543, 5448.645838020556, 5451.509364157245, 5475.342958844964, 5477.3427188737205, 5498.202760599691, 5500.147477141049, 5502.752376143083, 5108.821191258326, 5161.096808058613, 5171.844844654629, 5229.660072095302, 5246.134387826042, 5643.238162848045, 5672.858178545569, 5673.489385955284, 5675.971620141873, 5693.28833895763, 5371.301730774974, 5453.209284653783, 5459.672419654833, 5461.098918678453, 5461.617686761968, 5453.318335208099, 5458.836234912959, 5499.560035197254, 5514.0, 5558.861028474321, 5454.12733962572, 5464.316960379952, 5464.398916119224, 5466.453354664582, 5473.452654734495, 5383.084875571162, 5407.729613519308, 5455.208994695747, 5465.125579907275, 5518.144687573433, 4300.440942677432, 4327.069680018811, 4328.696991210648, 4336.718113322687, 4373.825046998148, 3817.0838998640124, 3819.255245227154, 3821.197548514843, 3840.9423858642144, 3855.479510266134, 5082.491750824962, 5124.180131178993, 5142.5628821549835, 5162.354705661793, 5201.557867581222, 5472.534834539029, 5483.0, 5496.532794712414, 5509.752061157257, 5564.165375193672, 5100.540951314325, 5208.140656791587, 5209.635325527177, 5211.166213405837, 5253.921191182136, 4638.072385522909, 4690.179218636725, 4746.288056791509, 4755.714657120584, 4772.522747725269, 5681.0, 5695.971520142372, 5709.0865461525955, 5776.56675749312, 5780.826575202666, 5524.226608274765, 5527.143292789624, 5528.778848846162, 5529.557635389239, 5530.0, 5526.41972592888, 5580.804671836466, 5668.433156684298, 5752.884942301214, 5765.192872997867, 5391.487808658171, 5402.59480538969, 5403.621746477709, 5404.243405923253, 5417.729113544228, 5489.835304940858, 5495.258140151029, 5504.752286147213, 5509.641873278224, 5543.750531226024, 5226.294450249167, 5352.732363381738, 5385.1922211667, 5422.6475279106735, 5453.10023846061, 5388.488093631099, 5418.214358918013, 5422.864428389322, 5423.810166644149, 5433.347998240079, 5203.219517072318, 5311.415744268204, 5330.733463326896, 5333.893322133613, 5386.084365657926, 5317.308749862493, 5345.118055520796, 5376.973115134556, 5433.375161856279, 5439.537639300704, 5250.474952504872, 5258.789648414174, 5278.577713782965, 5279.419263880894, 5282.207668849704], "unit": "score", "name": "dojo.html", "value": 5087.524029234308}, {"lowerIsBetter": false, "replicates": [517.4618396867261, 532.7389579106234, 536.2706718862347, 537.7714471349675, 544.3196004993757, 27576.31059223518, 28085.578716319247, 28130.578041329372, 35682.10794730133, 35863.46204806923, 38244.23511529768, 38649.61350386495, 38707.806460967724, 38711.83864484063, 38737.41893871594, 8391.580420978957, 8495.490270583754, 8566.443181193203, 8581.785455363635, 8584.914150858505, 7563.924360756377, 7745.148033716287, 10187.185025197967, 10362.171026317876, 10421.583136674524, 10053.748656283615, 10137.695869123938, 10140.847887281696, 10143.847842282372, 10157.238207134458, 9962.950185249063, 10035.849462258071, 10051.095401413835, 10057.497125143713, 10057.497125143713, 9778.266630002707, 9927.255455840841, 9930.45382503962, 9934.602615895428, 9937.75155621108, 35534.82232588846, 35990.64009359899, 39085.0, 39281.60718392808, 39352.212955740724, 3233.288676491192, 3299.686529779667, 3314.05549418417, 3515.701165400944, 3529.0824385659657, 29769.25576860574, 30041.399172016438, 30458.69541304603, 30462.39075218483, 30585.23536911595, 3873.4189871519216, 3886.844526218948, 3980.7014473914574, 3984.721069525134, 4083.6528895043957, 273975.0, 274192.0, 274805.0, 275609.62195189093, 276903.0, 56359.43640563624, 57936.42063579395, 58174.0, 58174.41825581775, 60190.69904650449, 60110.0, 60150.0, 60510.39489605048, 60600.39399605947, 60613.69693151506, 15439.768403473958, 15951.042937423792, 15961.44134955271, 15961.680766384607, 15979.60050998711, 11900.88099119015, 12086.274823510617, 12105.152639315163, 12134.089943254292, 12140.45367958444, 20015.399538013884, 20121.798782012283, 20220.292289769786, 20383.4904127398, 20438.182472701224, 7888.6450109744055, 8065.838683226302, 8067.435279530377, 8079.515229086156, 8190.099089100194, 947.8151760406655, 990.6631745206664, 1013.9036791504795, 1133.4219548030565, 1185.1526158796503, 29418.705812941596, 29437.85281073581, 29770.70229297679, 29861.0, 31179.844100779803, 1048.2714513413105, 1065.9733506662396, 1073.1522097543009, 1190.934498602585, 1195.6101478154808, 15340.769888451681, 15376.692466150615, 15447.382104715685, 15466.14936178521, 15611.609709757347, 365510.0, 372961.0, 374533.0, 374567.0, 376346.0, 52326.73836630869, 52652.47347526476, 52852.47147528476, 52862.0, 52885.0, 1321.8413790345028, 1355.9762379403487, 1385.2035079829138, 1386.2791348498724, 1490.5304828978838, 28384.290392740346, 28898.711012890442, 29136.56295155532, 29342.559861601665, 29533.556996645497, 42114.0, 45088.54911450844, 45436.77281613571, 45586.772066139456, 45597.316040260084, 279208.0, 279828.0, 281861.0, 282784.0, 284024.0, 29176.27059323534, 29474.0, 29769.702302976693, 29777.25556861096, 29891.252718682208, 37595.81202093972, 38630.42054369243, 38793.15063721426, 39026.219475610895, 39310.41034384429, 35260.294794104484, 35879.641203588675, 36099.27801443904, 36336.636633634385, 36670.816645917665, 35604.46593301155, 36068.4589731149, 36115.458268125476, 36288.4556731644, 36354.818225908704, 36852.81573592115, 39829.0, 40041.0, 40097.39853902252, 40158.0, 27880.721192787812, 30544.389112218076, 30884.0734777957, 30941.8452907743, 30978.225544361572, 24162.275131746075, 25134.24597262085, 25864.353391165372, 25955.870220648776, 26102.73897261003], "unit": "score", "name": "ext.html", "value": 18671.806750223474}, {"lowerIsBetter": false, "replicates": [352.6445867570071, 359.3567514149672, 360.5943313772003, 361.20715030508035, 361.50293346648357, 13557.25435101069, 13844.723105537883, 16265.268062937166, 16935.745963810554, 17450.825491745094, 15534.300956456958, 15588.220588970535, 16039.599010024755, 16089.597760056004, 16102.436414725487, 5268.31511903453, 5431.131019036935, 5432.13085906255, 5434.945650543504, 5438.91841622376, 4007.2185923744883, 5306.310179676637, 5346.786128554872, 5800.361960184377, 6011.57918945674, 5806.59353845231, 5889.0, 5940.138679891435, 5941.2276404067625, 5943.316518600352, 5248.763805628756, 5250.894982100336, 5252.579793616521, 5303.833156705518, 5306.867328316785, 4698.060387922429, 4699.976500117512, 4720.244760838284, 4760.166970780099, 4760.452547956995, 19672.409827705193, 19687.507812304808, 20097.0, 20279.08744106519, 20553.69169462459, 2198.6701994700925, 2337.3572267626537, 2607.973920260792, 2818.0841226601437, 2841.8863245470156, 12544.096440849617, 12577.811332830015, 12728.61814145577, 12731.172473789175, 12839.486420543168, 1831.423101722953, 1845.9261629534803, 1878.4176905159309, 1912.2733361322748, 1945.8443324534003, 57097.42902570963, 58582.41417585855, 59516.0, 60122.398776012116, 60332.0, 9603.087706667995, 9708.514574271258, 9911.306208565331, 9915.30592858493, 9925.801483970281, 13069.215847049207, 13126.474941002252, 13127.0, 13145.0, 13149.145305555108, 7772.961135194288, 7793.766187014398, 7822.647980840876, 7866.881996770053, 7890.250426209501, 7758.107817601048, 7769.339606133429, 7798.337141342936, 7799.181085986003, 7800.45396822217, 5986.790462333797, 6041.124037014608, 6054.939450605526, 6074.483668888194, 6117.663528505975, 1660.8588269996944, 1726.3181043487753, 1754.5701303180801, 1796.5059608607476, 1804.2151664026192, 921.3964853021148, 989.8812142542942, 1005.9144972677258, 1061.4851796878509, 1124.970651853545, 13895.722085558233, 16121.919390402973, 17411.912940435217, 17551.034693092002, 17634.647307053787, 865.3682811547606, 935.9578818953163, 948.6252930092713, 986.0977205856705, 1019.8781340525363, 9782.0, 10111.0, 10121.291509594257, 10138.391696498235, 10163.745906352253, 501270.0, 501866.0, 534353.0, 538058.0, 547491.0, 69282.65358673174, 73302.63348683223, 74421.25578744143, 74584.25415745773, 75534.62232688801, 1176.2178151529308, 1181.8404515390484, 1225.6323103069044, 1228.668259569911, 1243.30996297056, 15343.61640958985, 15406.383744650537, 15436.0, 15573.37706491773, 15936.0, 25416.110436134648, 33879.830600846835, 34478.65521344754, 34725.82637086798, 35504.64495355013, 46335.30497042614, 46924.530754692016, 47077.29384059173, 47205.29192062053, 47570.0, 7434.739784107746, 7625.351845093007, 7765.301122898966, 7785.065792104983, 7831.647575858986, 7615.666171322692, 9842.507874606097, 10375.84436233442, 10740.73148171302, 10744.892551074388, 9654.806903862023, 9862.358946668444, 10024.649137280161, 10058.446785426871, 10266.486675666038, 9896.851547226941, 9958.800823983625, 9964.800703986024, 10293.279470436997, 10337.37975721459, 7093.929060709534, 9529.0, 10008.199344052604, 10072.395656260647, 10155.89844101579, 7555.357794587521, 7567.281108294703, 7589.316961473494, 7597.6581053851605, 7615.238476152341, 8425.70510032146, 10415.270931034755, 10452.111570516592, 10615.840762388416, 10643.840342395026], "unit": "score", "name": "jquery.html", "value": 8441.78513103655}, {"lowerIsBetter": false, "replicates": [1310.1353106949416, 1440.539027511196, 1445.2340259662378, 1577.881658875584, 1753.8684598655095, 6899.551529150608, 7379.704811807528, 7416.295451932065, 7440.553566785983, 7529.661165247563, 7504.924950750491, 7512.399008079355, 7589.620518974043, 7597.8480430391355, 7614.048243969504, 1992.282778199847, 2031.6343058249508, 2310.919117830872, 2338.1348900906687, 2342.8008619267384, 2305.6080466320764, 2364.5034542746043, 2366.6213405855065, 2367.112332875172, 2367.490989437271, 2226.3988723044768, 2279.6010698127843, 2285.3029825903095, 2286.9542609147807, 2287.1537531113513, 1972.1026932745638, 2221.8111460525874, 2257.4582100295893, 2286.7141607299086, 2293.724753029647, 2266.5466906618576, 2268.1494439585153, 2296.8966396512196, 2304.585174668559, 2304.6543018547354, 7495.475316727831, 7515.361194298491, 7516.661750221253, 7563.130240022413, 7571.545707257527, 4575.862724118282, 4715.504871988426, 4719.62243020561, 4733.3846599942135, 4733.5503127202865, 3144.606924134483, 3156.6369867465305, 3167.33485967947, 3213.3252017076443, 3214.067920303109, 1009.7122320138725, 1027.275770581738, 1039.864817573718, 1058.0636137018794, 1059.814532456817, 10442.425666588335, 10518.631847885365, 10534.473276336152, 10547.050765431148, 10551.683449496528, 4186.665066794649, 4253.957460425356, 4317.827286908551, 4357.782110894443, 4362.0185458271635, 8856.335774816915, 8880.0, 8880.8667869982, 8912.376133670581, 8927.642894284156, 4753.453352864396, 4785.306130611111, 4787.0, 4789.521047895182, 4796.328514008042, 4301.451477468109, 4305.375720520569, 4306.246406878784, 4311.374850646639, 4312.805923733439, 3586.8744593939086, 3607.603163651996, 3639.9272014560092, 3644.2711457708565, 3742.7567208131927, 1157.4617802721775, 1164.796160671879, 1166.2710805746408, 1171.1977295552574, 1180.7756526259984, 963.8843338799389, 977.3695966101825, 979.5347210075299, 1085.8914108589236, 1363.6727185475415, 6702.162229721285, 6960.9303906961295, 6962.965185174143, 6968.198657154492, 7019.122609673791, 609.8231512861221, 614.7940439952666, 620.0389396435507, 631.3875540725489, 634.1185751804994, 5603.915941260884, 5672.319321681424, 5674.829755107354, 5713.171590119493, 5725.828225153252, 8847.823043539092, 9190.724278271662, 9198.356115071882, 9212.677556285498, 9298.628054877729, 9070.410423322463, 9190.035046320174, 9201.723948281562, 9206.217471514863, 9321.161095501302, 7010.789676309719, 7156.892646610305, 7165.068541089625, 7190.137183538009, 7223.819404514929, 7073.717051318095, 7100.396466300215, 7152.034475345969, 7164.749233776793, 7172.856542869218, 7961.243681850215, 7964.2433968772875, 8071.394645401501, 8220.177982201732, 8247.505149690798, 8174.754757357289, 8267.338612911073, 8283.83432331338, 8449.915500844912, 8457.323414126979, 6817.761378351734, 7000.719971201095, 7049.682764275723, 7051.964740176266, 7059.752908648173, 7400.444966627417, 7400.555966642019, 7409.925900740924, 7412.295831895961, 7467.1039475263315, 6774.0, 6898.517103802686, 7012.333828286304, 7041.3310735480045, 7090.822729431599, 6723.865522689421, 6884.621345826027, 6934.271901450275, 6945.583265004116, 7009.824754381181, 6148.78479253224, 6669.46644268467, 6727.192736871411, 6891.138607674041, 6902.689378978059, 5931.792387266598, 5952.5833191676165, 5963.105534169909, 6008.0, 6011.519078473624, 6143.784967526115, 6202.317745047951, 6223.37766223374, 6224.657643829632, 6224.751009959551], "unit": "score", "name": "mootools.html", "value": 4349.099842285244}, {"lowerIsBetter": false, "replicates": [320.1116900600834, 332.81029813006563, 333.7380156577087, 340.25823704324563, 340.558976125917, 5678.943210567893, 5815.534757219423, 5837.708114594275, 5914.172015917775, 5944.821655350335, 5673.943260567393, 5770.0, 5800.419958004198, 5807.070868661015, 5813.157092221625, 4537.4328208973875, 4538.818447262105, 4544.681872268942, 4545.590896819285, 4548.113117942003, 4365.869023929287, 4417.955820441786, 4491.124230775, 4509.278515437531, 4552.226121559343, 4480.484744254403, 4481.596656300949, 4483.932741008887, 4495.0, 4503.211937910869, 4507.481639611421, 4511.458624965009, 4511.6165125964335, 4513.571210734975, 4519.209138400784, 3981.7810020448865, 3984.9601503984877, 3988.66096381805, 3997.320455522568, 4002.6197511236387, 5335.039692855285, 5502.0, 5503.504684578367, 5514.035043867348, 5539.196816461631, 5167.018266529385, 5167.7674504647, 5168.7415629218385, 5170.715610641413, 5171.146760784503, 5976.223090998186, 6243.563980284514, 6246.0, 6248.9062664060075, 6268.310485846553, 4372.0, 4427.335899615051, 4435.556444355571, 4437.800298986554, 4441.444819397575, 6412.454941329993, 6507.6420796856155, 6519.608823470559, 6526.738930442777, 6527.771527996545, 4577.427821522309, 4578.35902973584, 4578.931316030262, 4582.747948862778, 4583.770811459413, 4546.636269098464, 4617.976910115428, 4641.118187544424, 4644.117617652635, 4652.906941861143, 5296.576273898079, 5297.5232229099565, 5302.072137375943, 5302.5683065572075, 5304.0, 6286.277078135981, 6288.339724328971, 6289.654069026156, 6296.496280297565, 6301.054841773679, 1619.0852168524746, 1646.0864220357578, 1646.1769115442278, 1646.1933652510183, 1649.6205872649357, 1111.3554138599593, 1112.8275117356823, 1124.2748427264369, 1138.2885696439726, 1152.464104191555, 5982.7008649568215, 5989.520838332923, 5999.070144127667, 6002.249718785152, 6003.909941350883, 6400.935990640127, 6417.069524918954, 6444.484441244689, 6444.709988050549, 6446.516511261674, 5891.911621325684, 5997.190379298739, 6041.184440100618, 6049.697515124314, 6051.788187413419, 3461.238527523941, 3477.2871561329866, 3486.6861982421706, 3487.4245749451056, 3491.9825400872833, 6770.661466926634, 6775.085363475868, 6775.559588626822, 6778.91537354021, 6780.355866192704, 6475.4819614430735, 6581.210254769362, 6584.209894812558, 6590.275069742324, 6594.472442204612, 6631.502637302222, 6711.127553418122, 6752.932470675329, 6763.6618169092335, 6770.086038384755, 6226.875462490815, 6310.242770867525, 6400.39196276353, 6414.93585064162, 6419.422251997343, 6389.594289256356, 6423.362042679274, 6436.581622194542, 6447.0651755494255, 6447.516436267392, 6794.660266986532, 6800.591964482147, 6801.965990170215, 6804.795856124324, 6817.420519255918, 4479.46246450428, 4504.752238626907, 4554.954450455453, 4561.977190114028, 4571.26859702446, 6448.258450278278, 6451.48388128958, 6464.644444555594, 6476.190476190476, 6483.805485835433, 6265.310815810166, 6293.622382657055, 6294.433500984934, 6304.275008373912, 6323.20959880015, 6170.6914654268, 6288.5598008138995, 6289.685515724287, 6289.710609325169, 6292.835825372321, 6190.164327815687, 6199.1011303361665, 6199.690015499117, 6200.441960223601, 6205.0, 6318.494520438262, 6334.113224148715, 6337.176167098432, 6344.333844946399, 6354.968225158845, 6080.695965201634, 6186.288576813724, 6188.535859810622, 6189.690515474298, 6197.380261973766], "unit": "score", "name": "prototype.html", "value": 4749.703393855833}, {"lowerIsBetter": false, "replicates": [707.9929200707993, 771.672039383262, 818.9344852411807, 819.9412906114734, 833.5415521463198, 12433.129680922328, 12556.623301300975, 12582.182158159712, 12583.182093163938, 12603.0, 12544.937275313634, 12863.228206307627, 12993.2204067756, 13054.543090991818, 13057.0, 691.495208497797, 699.7445932234749, 816.0696805641574, 817.1868990354606, 842.1241908415241, 831.3972370031709, 839.7900524868783, 840.9621567029468, 841.0706169682504, 842.0400743152811, 873.3100850328233, 875.7460336502406, 876.5529579914225, 877.1886005444937, 881.1056777370974, 713.4007433755644, 850.2560259772699, 860.1484530315006, 863.1713554987219, 865.0570877743227, 633.882731694638, 634.8857205702972, 638.8498702804884, 638.8913884639576, 639.3542522052713, 13229.140105893086, 13251.337433128401, 13290.601281961557, 13297.202167869862, 13304.334783260798, 12867.970562354989, 12920.160189587647, 13254.271015094166, 13314.600561983156, 13320.400581973738, 10328.225383096298, 10545.947270263676, 10630.0, 10705.83941240882, 10711.089557387631, 3235.5955505561806, 3301.240714635623, 3334.1831251343333, 3348.2131699050706, 3397.6602339766073, 47951.5204847954, 49716.50283497155, 49759.0, 49792.50207497951, 49810.750946245396, 9690.079442452956, 9745.805083898424, 10039.799204015879, 10150.03574660406, 10177.287589868638, 18934.147963341406, 18968.24127034903, 18994.0, 19000.33498827562, 19029.714554281698, 7783.494072885244, 7821.92178078212, 7844.37245020397, 7927.762167134995, 8019.518828870287, 4199.328107502785, 4207.8316867325575, 4234.216669916075, 4246.0, 4268.167707297047, 3131.7181453668823, 3131.7807753457496, 3139.984300078485, 3159.873605055818, 3162.6995435433596, 567.5005994724615, 572.2389222334285, 578.7424596054799, 587.6679675983056, 600.0968542343832, 577.7544543568966, 627.3193584960278, 704.3695892176473, 707.3307440861499, 719.597025665629, 7646.0, 7957.840843183104, 8088.676452941934, 8595.699150529701, 8753.912460875437, 591.8837321502294, 621.0901029990995, 637.9537558404221, 651.6155468273741, 652.4063102576632, 3802.5056742623833, 3863.208042351311, 3884.9028774280305, 3963.2667956428154, 4116.485439320085, 55922.72038639781, 58546.12180817291, 58589.707051465324, 58593.0, 58678.413215867295, 50674.74662626737, 50931.23603145956, 51043.23435148476, 51937.0, 51949.480505194464, 44736.55263447454, 45274.0, 45471.31793023041, 45597.54402456, 45647.0, 8064.0, 8165.0, 8401.117882622237, 8434.915650843659, 8528.616212270339, 33419.33161336711, 33420.498692520116, 34077.48883766696, 34150.82924585361, 34910.301793963474, 40062.599374007055, 40214.79892600518, 41619.7919010403, 42580.0, 42594.361084583135, 10803.45982700846, 11080.224384293344, 11131.443427828739, 11231.382273974683, 11324.150688698215, 12541.0, 12550.811737823757, 12586.118971672262, 12811.167274127152, 13190.538331158363, 11735.295882247092, 12105.455254513745, 12108.0, 12505.562305319634, 12643.747125057631, 11653.126015549038, 11715.121365897421, 11818.290902545874, 11920.582779602672, 12266.815997760219, 11380.146489013523, 11638.592649257236, 11702.88297117052, 11831.053515718893, 12209.145359824726, 9619.086942895456, 9795.706128816148, 9811.509424528602, 9909.405435673883, 10345.585956634442, 9226.723198304062, 9538.332316737762, 9788.265880059167, 9894.455804930798, 10380.688579342632], "unit": "score", "name": "yui.html", "value": 6322.830880085718}], "name": "dromaeo_css", "value": 6865.795168024018}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 112.0, 102.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 158.0, 166.0, 128.0, 150.0, 152.0, 127.0, 173.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 163.0, 162.0, 161.0, 162.0, 166.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 105.0, 93.0, 74.0, 78.0, 73.0, 120.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 156.0, 96.0, 96.0, 97.0, 140.0, 97.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 114.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 145.0, 146.0, 148.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 56.0, 55.0, 55.0, 54.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 87.0, 85.0, 85.0, 86.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 123.0, 115.0, 126.0, 115.0, 121.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [154.0, 140.0, 151.0, 150.0, 163.0, 144.0, 150.0, 150.0, 153.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 70.0, 70.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1520.1000000000001}]} 14:38:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6865.79"}}} 14:38:29 INFO - Return code: 0 14:38:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:29 INFO - # TBPL SUCCESS # 14:38:29 INFO - Running post-action listener: _resource_record_post_action 14:38:29 INFO - Running post-run listener: _resource_record_post_run 14:38:30 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 539684864; Read time: 0; Write time: 438008 14:38:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241156096; Read time: 0; Write time: 231548 14:38:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298528768; Read time: 0; Write time: 206460 14:38:30 INFO - Running post-run listener: _upload_blobber_files 14:38:30 INFO - Blob upload gear active. 14:38:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:38:30 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:38:30 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:38:30 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:38:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:31 INFO - (blobuploader) - INFO - Done attempting. 14:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:32 INFO - (blobuploader) - INFO - Done attempting. 14:38:32 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:32 INFO - Return code: 0 14:38:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:38:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4a04bd402611b0d951883cc1882b68808cb4e1e1831ead2f3d01eacad32d3b8380869715723ca2bb8bce5f3084c45e096b862c50a655cc43c54723bc22576118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc0ede014bc1217979d8cfcbf1103a02f4a13121ec0cab040c0d85c40911233c90b3c78140f29f22f6b4ca1b6899b4be7af80a5a912c4a11df921dd9a336dc08"} 14:38:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:38:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:38:32 INFO - Contents: 14:38:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4a04bd402611b0d951883cc1882b68808cb4e1e1831ead2f3d01eacad32d3b8380869715723ca2bb8bce5f3084c45e096b862c50a655cc43c54723bc22576118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc0ede014bc1217979d8cfcbf1103a02f4a13121ec0cab040c0d85c40911233c90b3c78140f29f22f6b4ca1b6899b4be7af80a5a912c4a11df921dd9a336dc08"} 14:38:32 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:32 INFO - Copying logs to upload dir... 14:38:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:38:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.353207 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-10 14:38:32.262693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 14:38:32.265932) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4a04bd402611b0d951883cc1882b68808cb4e1e1831ead2f3d01eacad32d3b8380869715723ca2bb8bce5f3084c45e096b862c50a655cc43c54723bc22576118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc0ede014bc1217979d8cfcbf1103a02f4a13121ec0cab040c0d85c40911233c90b3c78140f29f22f6b4ca1b6899b4be7af80a5a912c4a11df921dd9a336dc08"} build_url:https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/HRl1kuz3RzORyZAJRhULKw/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/B2G-Inbound/sha512/4a04bd402611b0d951883cc1882b68808cb4e1e1831ead2f3d01eacad32d3b8380869715723ca2bb8bce5f3084c45e096b862c50a655cc43c54723bc22576118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc0ede014bc1217979d8cfcbf1103a02f4a13121ec0cab040c0d85c40911233c90b3c78140f29f22f6b4ca1b6899b4be7af80a5a912c4a11df921dd9a336dc08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 14:38:32.292576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:38:32.292995) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1455142375.195729-852236161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004795 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 14:38:32.375973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 14:38:32.376442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 14:38:32.376775) ========= ========= Total master_lag: 0.32 =========