builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1455801033.14 results: success (0) buildid: 20160218023022 builduid: 7e2427ce6ea549ffb9ba9e8b59013443 revision: 46f2f4ce7b982028bdfa56c6266aaad82be14e2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.137643) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.138217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.138555) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.161996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.162316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.176321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.176710) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.226434) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.226732) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.227115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.227393) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-18 05:10:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2016-02-18 05:10:33 (13.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.392854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.393173) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.442693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:33.443063) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 46f2f4ce7b982028bdfa56c6266aaad82be14e2b --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 46f2f4ce7b982028bdfa56c6266aaad82be14e2b --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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-18 05:10:33,815 truncating revision to first 12 chars 2016-02-18 05:10:33,815 Setting DEBUG logging. 2016-02-18 05:10:33,816 attempt 1/10 2016-02-18 05:10:33,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/46f2f4ce7b98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 05:10:34,070 unpacking tar archive at: b2g-inbound-46f2f4ce7b98/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:34.003574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:34.004001) ========= echo 46f2f4ce7b982028bdfa56c6266aaad82be14e2b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'46f2f4ce7b982028bdfa56c6266aaad82be14e2b'] 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 46f2f4ce7b982028bdfa56c6266aaad82be14e2b program finished with exit code 0 elapsedTime=0.003995 script_repo_revision: '46f2f4ce7b982028bdfa56c6266aaad82be14e2b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:34.054015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:34.054382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 05:10:34.064531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-18 05:10:34.064988) ========= /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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:34 INFO - MultiFileLogger online at 20160218 05:10:34 in /builds/slave/test-pgo 05:10:34 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 05:10:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:10:34 INFO - {'append_to_log': False, 05:10:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:10:34 INFO - 'blob_upload_branch': 'B2G-Inbound', 05:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:10:34 INFO - 'branch': 'B2G-Inbound', 05:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:34 INFO - 'config_files': ('talos/linux_config.py',), 05:10:34 INFO - 'default_actions': ('clobber', 05:10:34 INFO - 'read-buildbot-config', 05:10:34 INFO - 'download-and-extract', 05:10:34 INFO - 'populate-webroot', 05:10:34 INFO - 'create-virtualenv', 05:10:34 INFO - 'install', 05:10:34 INFO - 'run-tests'), 05:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:34 INFO - 'download_minidump_stackwalk': True, 05:10:34 INFO - 'download_symbols': 'ondemand', 05:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:34 INFO - 'installer_path': 'installer.exe', 05:10:34 INFO - 'log_level': 'info', 05:10:34 INFO - 'log_name': 'talos', 05:10:34 INFO - 'log_to_console': True, 05:10:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:34 INFO - 'opt_config_files': (), 05:10:34 INFO - 'pip_index': False, 05:10:34 INFO - 'sps_profile': False, 05:10:34 INFO - 'sps_profile_interval': 0, 05:10:34 INFO - 'suite': 'dromaeojs', 05:10:34 INFO - 'system_bits': '32', 05:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:34 INFO - 'title': 'talos-linux64-ix-018', 05:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:34 INFO - 'use_talos_json': True, 05:10:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:34 INFO - 'work_dir': 'build'} 05:10:34 INFO - ##### 05:10:34 INFO - ##### Running clobber step. 05:10:34 INFO - ##### 05:10:34 INFO - Running pre-action listener: _resource_record_pre_action 05:10:34 INFO - Running main action method: clobber 05:10:34 INFO - rmtree: /builds/slave/test-pgo/build 05:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:10:34 INFO - Running post-action listener: _resource_record_post_action 05:10:34 INFO - ##### 05:10:34 INFO - ##### Running read-buildbot-config step. 05:10:34 INFO - ##### 05:10:34 INFO - Running pre-action listener: _resource_record_pre_action 05:10:34 INFO - Running main action method: read_buildbot_config 05:10:34 INFO - Using buildbot properties: 05:10:34 INFO - { 05:10:34 INFO - "project": "", 05:10:34 INFO - "product": "firefox", 05:10:34 INFO - "script_repo_revision": "production", 05:10:34 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:10:34 INFO - "repository": "", 05:10:34 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 05:10:34 INFO - "buildid": "20160218023022", 05:10:34 INFO - "pgo_build": "True", 05:10:34 INFO - "basedir": "/builds/slave/test-pgo", 05:10:34 INFO - "buildnumber": 262, 05:10:34 INFO - "slavename": "talos-linux64-ix-018", 05:10:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:34 INFO - "platform": "ubuntu64_hw", 05:10:34 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 05:10:34 INFO - "branch": "b2g-inbound", 05:10:34 INFO - "repo_path": "integration/b2g-inbound", 05:10:34 INFO - "revision": "46f2f4ce7b982028bdfa56c6266aaad82be14e2b", 05:10:34 INFO - "stage_platform": "linux64-pgo", 05:10:34 INFO - "builduid": "7e2427ce6ea549ffb9ba9e8b59013443", 05:10:34 INFO - "slavebuilddir": "test" 05:10:34 INFO - } 05:10:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:10:34 INFO - Running post-action listener: _resource_record_post_action 05:10:34 INFO - ##### 05:10:34 INFO - ##### Running download-and-extract step. 05:10:34 INFO - ##### 05:10:34 INFO - Running pre-action listener: _resource_record_pre_action 05:10:34 INFO - Running main action method: download_and_extract 05:10:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:10: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')]} 05:10:34 INFO - https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/test_packages.json 05:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/test_packages.json 05:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:10:35 INFO - Downloaded 1448 bytes. 05:10:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:10:35 INFO - Using the following test package requirements: 05:10:35 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:35 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:35 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:35 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'jsshell-linux-x86_64.zip'], 05:10:35 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:35 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:35 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:35 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:35 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:35 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:35 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:35 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:35 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')]} 05:10:35 INFO - https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:36 INFO - Downloaded 23346493 bytes. 05:10:36 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'] 05:10:36 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 05:10:37 INFO - Return code: 0 05:10:37 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 05:10:37 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')]} 05:10:37 INFO - https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:38 INFO - Downloaded 23346493 bytes. 05:10:38 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'] 05:10:38 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 05:10:40 INFO - Return code: 0 05:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:40 INFO - https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:40 INFO - Downloaded 10707071 bytes. 05:10:40 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'] 05:10:40 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 05:10:41 INFO - Return code: 0 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:41 INFO - https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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 05:10:43 INFO - Downloaded 56588651 bytes. 05:10:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:10:43 INFO - mkdir: /builds/slave/test-pgo/properties 05:10:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:10:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:10:43 INFO - Contents: 05:10:43 INFO - build_url:https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:10:44 INFO - Running post-action listener: _resource_record_post_action 05:10:44 INFO - Running post-action listener: set_extra_try_arguments 05:10:44 INFO - ##### 05:10:44 INFO - ##### Running populate-webroot step. 05:10:44 INFO - ##### 05:10:44 INFO - Running pre-action listener: _resource_record_pre_action 05:10:44 INFO - Running main action method: populate_webroot 05:10:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:44 INFO - '--tppagecycles', 05:10:44 INFO - '7'], 05:10:44 INFO - 'tests': ['tsvgm']}}, 05:10:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:10:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'tests': ['damp', 'tps']}, 05:10:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['damp', 'tps']}, 05:10:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:44 INFO - 'other': {'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'other_l64': {'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:44 INFO - 'ts_paint', 05:10:44 INFO - 'tpaint', 05:10:44 INFO - 'sessionrestore', 05:10:44 INFO - 'sessionrestore_no_auto_restore']}, 05:10:44 INFO - 'svgr': {'tests': ['tsvgx', 05:10:44 INFO - 'tsvgr_opacity', 05:10:44 INFO - 'tart', 05:10:44 INFO - 'tscrollx', 05:10:44 INFO - 'cart']}, 05:10:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['tsvgx', 05:10:44 INFO - 'tsvgr_opacity', 05:10:44 INFO - 'tart', 05:10:44 INFO - 'tscrollx', 05:10:44 INFO - 'cart']}, 05:10:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'tests': ['tp5o']}, 05:10:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'talos_options': ['--e10s'], 05:10:44 INFO - 'tests': ['tp5o']}, 05:10:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'talos_options': ['--xperf_path', 05:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:44 INFO - 'tests': ['tp5n']}, 05:10:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:44 INFO - 'talos_options': ['--e10s', 05:10:44 INFO - '--xperf_path', 05:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:44 INFO - 'tests': ['tp5n']}}, 05:10:44 INFO - 'talos.zip': {'path': '', 05:10:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:44 INFO - Running post-action listener: _resource_record_post_action 05:10:44 INFO - ##### 05:10:44 INFO - ##### Running create-virtualenv step. 05:10:44 INFO - ##### 05:10:44 INFO - Running pre-action listener: _resource_record_pre_action 05:10:44 INFO - Running main action method: create_virtualenv 05:10:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:10:44 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 05:10:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:10:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:44 INFO - Using real prefix '/usr' 05:10:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:46 INFO - Installing pip.................done. 05:10:46 INFO - Return code: 0 05:10:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:10:46 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')]} 05:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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')]} 05:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:46 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 05:10:46 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 05:10:46 INFO - Using env: {'DISPLAY': ':0', 05:10:46 INFO - 'HOME': '/home/cltbld', 05:10:46 INFO - 'LANG': 'en_US.UTF-8', 05:10:46 INFO - 'LANGUAGE': 'en_US:en', 05:10:46 INFO - 'LOGNAME': 'cltbld', 05:10:46 INFO - 'MAIL': '/var/mail/cltbld', 05:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:46 INFO - 'MOZ_NO_REMOTE': '1', 05:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:46 INFO - 'NO_EM_RESTART': '1', 05:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:46 INFO - 'SHELL': '/bin/bash', 05:10:46 INFO - 'SHLVL': '1', 05:10:46 INFO - 'TERM': 'linux', 05:10:46 INFO - 'TMOUT': '86400', 05:10:46 INFO - 'USER': 'cltbld', 05:10:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:46 INFO - '_': '/tools/buildbot/bin/python'} 05:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:46 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 05:10:46 INFO - Cleaning up... 05:10:46 INFO - Return code: 0 05:10:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:10:46 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')]} 05:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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')]} 05:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:46 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 05:10:46 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 05:10:46 INFO - Using env: {'DISPLAY': ':0', 05:10:46 INFO - 'HOME': '/home/cltbld', 05:10:46 INFO - 'LANG': 'en_US.UTF-8', 05:10:46 INFO - 'LANGUAGE': 'en_US:en', 05:10:46 INFO - 'LOGNAME': 'cltbld', 05:10:46 INFO - 'MAIL': '/var/mail/cltbld', 05:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:46 INFO - 'MOZ_NO_REMOTE': '1', 05:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:46 INFO - 'NO_EM_RESTART': '1', 05:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:46 INFO - 'SHELL': '/bin/bash', 05:10:46 INFO - 'SHLVL': '1', 05:10:46 INFO - 'TERM': 'linux', 05:10:46 INFO - 'TMOUT': '86400', 05:10:46 INFO - 'USER': 'cltbld', 05:10:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:46 INFO - '_': '/tools/buildbot/bin/python'} 05:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:47 INFO - Downloading/unpacking psutil>=0.7.1 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:47 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 05:10:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:49 INFO - Installing collected packages: psutil 05:10:49 INFO - Running setup.py install for psutil 05:10:49 INFO - building 'psutil._psutil_linux' extension 05:10:49 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 05:10:49 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 05:10:49 INFO - building 'psutil._psutil_posix' extension 05:10:49 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 05:10:49 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 05:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:49 INFO - Successfully installed psutil 05:10:49 INFO - Cleaning up... 05:10:49 INFO - Return code: 0 05:10:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:49 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:49 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 05:10:49 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 05:10:49 INFO - Using env: {'DISPLAY': ':0', 05:10:49 INFO - 'HOME': '/home/cltbld', 05:10:49 INFO - 'LANG': 'en_US.UTF-8', 05:10:49 INFO - 'LANGUAGE': 'en_US:en', 05:10:49 INFO - 'LOGNAME': 'cltbld', 05:10:49 INFO - 'MAIL': '/var/mail/cltbld', 05:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:49 INFO - 'MOZ_NO_REMOTE': '1', 05:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:49 INFO - 'NO_EM_RESTART': '1', 05:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:49 INFO - 'SHELL': '/bin/bash', 05:10:49 INFO - 'SHLVL': '1', 05:10:49 INFO - 'TERM': 'linux', 05:10:49 INFO - 'TMOUT': '86400', 05:10:49 INFO - 'USER': 'cltbld', 05:10:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:49 INFO - '_': '/tools/buildbot/bin/python'} 05:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:49 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 05:10:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:51 INFO - Installing collected packages: mozsystemmonitor 05:10:51 INFO - Running setup.py install for mozsystemmonitor 05:10:51 INFO - Successfully installed mozsystemmonitor 05:10:51 INFO - Cleaning up... 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:10:51 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')]} 05:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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')]} 05:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:51 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 05:10:51 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 05:10:51 INFO - Using env: {'DISPLAY': ':0', 05:10:51 INFO - 'HOME': '/home/cltbld', 05:10:51 INFO - 'LANG': 'en_US.UTF-8', 05:10:51 INFO - 'LANGUAGE': 'en_US:en', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MAIL': '/var/mail/cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SHLVL': '1', 05:10:51 INFO - 'TERM': 'linux', 05:10:51 INFO - 'TMOUT': '86400', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - '_': '/tools/buildbot/bin/python'} 05:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:52 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 05:10:52 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 05:10:52 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 05:10:52 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 05:10:52 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 05:10:52 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 05:10:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:10:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:54 INFO - Downloading docopt-0.6.1.tar.gz 05:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:54 INFO - Running setup.py install for blobuploader 05:10:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:10:54 INFO - Running setup.py install for requests 05:10:55 INFO - Running setup.py install for docopt 05:10:55 INFO - Successfully installed blobuploader requests docopt 05:10:55 INFO - Cleaning up... 05:10:55 INFO - Return code: 0 05:10:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:55 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:55 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 05:10:55 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 05:10:55 INFO - Using env: {'DISPLAY': ':0', 05:10:55 INFO - 'HOME': '/home/cltbld', 05:10:55 INFO - 'LANG': 'en_US.UTF-8', 05:10:55 INFO - 'LANGUAGE': 'en_US:en', 05:10:55 INFO - 'LOGNAME': 'cltbld', 05:10:55 INFO - 'MAIL': '/var/mail/cltbld', 05:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:55 INFO - 'MOZ_NO_REMOTE': '1', 05:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:55 INFO - 'NO_EM_RESTART': '1', 05:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:55 INFO - 'SHELL': '/bin/bash', 05:10:55 INFO - 'SHLVL': '1', 05:10:55 INFO - 'TERM': 'linux', 05:10:55 INFO - 'TMOUT': '86400', 05:10:55 INFO - 'USER': 'cltbld', 05:10:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:55 INFO - '_': '/tools/buildbot/bin/python'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:55 INFO - Running setup.py (path:/tmp/pip-CisU3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:55 INFO - Running setup.py (path:/tmp/pip-nDQNY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:55 INFO - Running setup.py (path:/tmp/pip-kHVB1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:55 INFO - Running setup.py (path:/tmp/pip-TCqWrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:55 INFO - Running setup.py (path:/tmp/pip-1Nj_oJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:55 INFO - Running setup.py (path:/tmp/pip-XU_3oM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:55 INFO - Running setup.py (path:/tmp/pip-A8GncU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:55 INFO - Running setup.py (path:/tmp/pip-g0u9qL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:56 INFO - Running setup.py (path:/tmp/pip-o_iLls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:56 INFO - Running setup.py (path:/tmp/pip-ytrNuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:56 INFO - Running setup.py (path:/tmp/pip-RGWvdJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:56 INFO - Running setup.py (path:/tmp/pip-wUOGoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:56 INFO - Running setup.py (path:/tmp/pip-vNGZpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:56 INFO - Running setup.py (path:/tmp/pip-FIMnLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:56 INFO - Running setup.py (path:/tmp/pip-mCCR30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:56 INFO - Running setup.py (path:/tmp/pip-9OMyIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:56 INFO - Running setup.py (path:/tmp/pip-DtpXjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:56 INFO - Running setup.py install for manifestparser 05:10:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:10:56 INFO - Running setup.py install for mozcrash 05:10:56 INFO - Running setup.py install for mozdebug 05:10:56 INFO - Running setup.py install for mozdevice 05:10:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozfile 05:10:57 INFO - Running setup.py install for mozhttpd 05:10:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozinfo 05:10:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozInstall 05:10:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozleak 05:10:57 INFO - Running setup.py install for mozlog 05:10:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for moznetwork 05:10:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozprocess 05:10:57 INFO - Running setup.py install for mozprofile 05:10:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:10:57 INFO - Running setup.py install for mozrunner 05:10:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:10:58 INFO - Running setup.py install for mozscreenshot 05:10:58 INFO - Running setup.py install for moztest 05:10:58 INFO - Running setup.py install for mozversion 05:10:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:10:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10: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')]} 05:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:58 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:10:58 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 05:10:58 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 05:10:58 INFO - Using env: {'DISPLAY': ':0', 05:10:58 INFO - 'HOME': '/home/cltbld', 05:10:58 INFO - 'LANG': 'en_US.UTF-8', 05:10:58 INFO - 'LANGUAGE': 'en_US:en', 05:10:58 INFO - 'LOGNAME': 'cltbld', 05:10:58 INFO - 'MAIL': '/var/mail/cltbld', 05:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:58 INFO - 'MOZ_NO_REMOTE': '1', 05:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:58 INFO - 'NO_EM_RESTART': '1', 05:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:58 INFO - 'SHELL': '/bin/bash', 05:10:58 INFO - 'SHLVL': '1', 05:10:58 INFO - 'TERM': 'linux', 05:10:58 INFO - 'TMOUT': '86400', 05:10:58 INFO - 'USER': 'cltbld', 05:10:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:58 INFO - '_': '/tools/buildbot/bin/python'} 05:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:58 INFO - Running setup.py (path:/tmp/pip-345BM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:58 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)) 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:58 INFO - Running setup.py (path:/tmp/pip-s0KoyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:58 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)) 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:58 INFO - Running setup.py (path:/tmp/pip-TrUYIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:58 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)) 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:58 INFO - Running setup.py (path:/tmp/pip-BknwW_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:58 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)) 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:58 INFO - Running setup.py (path:/tmp/pip-nsZZ_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:58 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)) 05:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:58 INFO - Running setup.py (path:/tmp/pip-tm1odZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:59 INFO - Running setup.py (path:/tmp/pip-ShKcEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:59 INFO - Running setup.py (path:/tmp/pip-Zidkhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:59 INFO - Running setup.py (path:/tmp/pip-dkX_V_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:59 INFO - Running setup.py (path:/tmp/pip-VC_VvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:59 INFO - Running setup.py (path:/tmp/pip-FkjwNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:59 INFO - Running setup.py (path:/tmp/pip-GdFXsc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:59 INFO - Running setup.py (path:/tmp/pip-Z4kb5O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:59 INFO - Running setup.py (path:/tmp/pip-FyoC2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:59 INFO - Running setup.py (path:/tmp/pip-wvBZFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:59 INFO - Running setup.py (path:/tmp/pip-zt7d4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:59 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)) 05:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:59 INFO - Running setup.py (path:/tmp/pip-0iwCKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:59 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)) 05:10:59 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)) 05:10:59 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)) 05:10:59 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)) 05:10:59 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)) 05:10:59 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)) 05:10:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - Downloading blessings-1.6.tar.gz 05:11:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:01 INFO - Installing collected packages: blessings 05:11:01 INFO - Running setup.py install for blessings 05:11:01 INFO - Successfully installed blessings 05:11:01 INFO - Cleaning up... 05:11:01 INFO - Return code: 0 05:11:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:11:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:11:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:11:02 INFO - Reading from file tmpfile_stdout 05:11:02 INFO - Current package versions: 05:11:02 INFO - argparse == 1.2.1 05:11:02 INFO - blessings == 1.6 05:11:02 INFO - blobuploader == 1.2.4 05:11:02 INFO - docopt == 0.6.1 05:11:02 INFO - manifestparser == 1.1 05:11:02 INFO - mozInstall == 1.12 05:11:02 INFO - mozcrash == 0.16 05:11:02 INFO - mozdebug == 0.1 05:11:02 INFO - mozdevice == 0.48 05:11:02 INFO - mozfile == 1.2 05:11:02 INFO - mozhttpd == 0.7 05:11:02 INFO - mozinfo == 0.9 05:11:02 INFO - mozleak == 0.1 05:11:02 INFO - mozlog == 3.1 05:11:02 INFO - moznetwork == 0.27 05:11:02 INFO - mozprocess == 0.22 05:11:02 INFO - mozprofile == 0.28 05:11:02 INFO - mozrunner == 6.11 05:11:02 INFO - mozscreenshot == 0.1 05:11:02 INFO - mozsystemmonitor == 0.0 05:11:02 INFO - moztest == 0.7 05:11:02 INFO - mozversion == 1.4 05:11:02 INFO - psutil == 3.1.1 05:11:02 INFO - requests == 1.2.3 05:11:02 INFO - wsgiref == 0.1.2 05:11:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:11:02 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')]} 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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')]} 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:11:02 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 05:11:02 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 05:11:02 INFO - Using env: {'DISPLAY': ':0', 05:11:02 INFO - 'HOME': '/home/cltbld', 05:11:02 INFO - 'LANG': 'en_US.UTF-8', 05:11:02 INFO - 'LANGUAGE': 'en_US:en', 05:11:02 INFO - 'LOGNAME': 'cltbld', 05:11:02 INFO - 'MAIL': '/var/mail/cltbld', 05:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:02 INFO - 'MOZ_NO_REMOTE': '1', 05:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:02 INFO - 'NO_EM_RESTART': '1', 05:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:02 INFO - 'SHELL': '/bin/bash', 05:11:02 INFO - 'SHLVL': '1', 05:11:02 INFO - 'TERM': 'linux', 05:11:02 INFO - 'TMOUT': '86400', 05:11:02 INFO - 'USER': 'cltbld', 05:11:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:02 INFO - '_': '/tools/buildbot/bin/python'} 05:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 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)) 05:11:02 INFO - Cleaning up... 05:11:02 INFO - Return code: 0 05:11:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:11:02 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')]} 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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')]} 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:11:02 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 05:11:02 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 05:11:02 INFO - Using env: {'DISPLAY': ':0', 05:11:02 INFO - 'HOME': '/home/cltbld', 05:11:02 INFO - 'LANG': 'en_US.UTF-8', 05:11:02 INFO - 'LANGUAGE': 'en_US:en', 05:11:02 INFO - 'LOGNAME': 'cltbld', 05:11:02 INFO - 'MAIL': '/var/mail/cltbld', 05:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:02 INFO - 'MOZ_NO_REMOTE': '1', 05:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:02 INFO - 'NO_EM_RESTART': '1', 05:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:02 INFO - 'SHELL': '/bin/bash', 05:11:02 INFO - 'SHLVL': '1', 05:11:02 INFO - 'TERM': 'linux', 05:11:02 INFO - 'TMOUT': '86400', 05:11:02 INFO - 'USER': 'cltbld', 05:11:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:02 INFO - '_': '/tools/buildbot/bin/python'} 05:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:02 INFO - Downloading/unpacking jsonschema 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:04 INFO - Downloading/unpacking functools32 (from jsonschema) 05:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:04 INFO - warning: no files found matching '*.txt' 05:11:04 INFO - no previously-included directories found matching 'build' 05:11:04 INFO - no previously-included directories found matching 'dist' 05:11:04 INFO - no previously-included directories found matching '.git*' 05:11:04 INFO - Installing collected packages: jsonschema, functools32 05:11:04 INFO - Running setup.py install for functools32 05:11:04 INFO - warning: no files found matching '*.txt' 05:11:04 INFO - no previously-included directories found matching 'build' 05:11:04 INFO - no previously-included directories found matching 'dist' 05:11:04 INFO - no previously-included directories found matching '.git*' 05:11:04 INFO - Successfully installed jsonschema functools32 05:11:04 INFO - Cleaning up... 05:11:04 INFO - Return code: 0 05:11:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a4b968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, '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': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', '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 05:11:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:11:04 INFO - Using env: {'DISPLAY': ':0', 05:11:04 INFO - 'HOME': '/home/cltbld', 05:11:04 INFO - 'LANG': 'en_US.UTF-8', 05:11:04 INFO - 'LANGUAGE': 'en_US:en', 05:11:04 INFO - 'LOGNAME': 'cltbld', 05:11:04 INFO - 'MAIL': '/var/mail/cltbld', 05:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:04 INFO - 'MOZ_NO_REMOTE': '1', 05:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:04 INFO - 'NO_EM_RESTART': '1', 05:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:04 INFO - 'SHELL': '/bin/bash', 05:11:04 INFO - 'SHLVL': '1', 05:11:04 INFO - 'TERM': 'linux', 05:11:04 INFO - 'TMOUT': '86400', 05:11:04 INFO - 'USER': 'cltbld', 05:11:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:04 INFO - '_': '/tools/buildbot/bin/python'} 05:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:05 INFO - Downloading/unpacking flake8 05:11:05 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 05:11:05 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 05:11:05 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 05:11:05 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 05:11:05 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 05:11:05 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 05:11:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:07 INFO - no previously-included directories found matching 'docs/_build' 05:11:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:07 INFO - Running setup.py install for pep8 05:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:07 INFO - no previously-included directories found matching 'docs/_build' 05:11:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:11:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:07 INFO - Cleaning up... 05:11:07 INFO - Return code: 0 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - Running post-action listener: _start_resource_monitoring 05:11:07 INFO - Starting resource monitoring. 05:11:07 INFO - ##### 05:11:07 INFO - ##### Running install step. 05:11:07 INFO - ##### 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: install 05:11:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:11:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:11:08 INFO - Reading from file tmpfile_stdout 05:11:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:11:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:11:08 INFO - Reading from file tmpfile_stdout 05:11:08 INFO - Output received: 05:11:08 INFO - Usage: mozinstall [options] installer 05:11:08 INFO - Options: 05:11:08 INFO - -h, --help show this help message and exit 05:11:08 INFO - -d DEST, --destination=DEST 05:11:08 INFO - Directory to install application into. [default: 05:11:08 INFO - "/builds/slave/test-pgo"] 05:11:08 INFO - --app=APP Application being installed. [default: firefox] 05:11:08 INFO - mkdir: /builds/slave/test-pgo/build/application 05:11:08 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'] 05:11:08 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 05:11:24 INFO - Reading from file tmpfile_stdout 05:11:24 INFO - Output received: 05:11:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:11:24 INFO - Running post-action listener: _resource_record_post_action 05:11:24 INFO - ##### 05:11:24 INFO - ##### Running run-tests step. 05:11:24 INFO - ##### 05:11:24 INFO - Running pre-action listener: _resource_record_pre_action 05:11:24 INFO - Running main action method: run_tests 05:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:11:24 INFO - Python 2.7.3 05:11:24 INFO - Return code: 0 05:11:24 INFO - grabbing minidump binary from tooltool 05:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:24 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 0x1f428c0>, '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 0x1f437c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f43c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:11:24 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 05:11:24 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 05:11:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:24 INFO - Return code: 0 05:11:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:11:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:11:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:11:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:11:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:11:25 INFO - Return code: 0 05:11:25 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/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 05:11:25 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/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 05:11:25 INFO - Using env: {'DISPLAY': ':0', 05:11:25 INFO - 'HOME': '/home/cltbld', 05:11:25 INFO - 'LANG': 'en_US.UTF-8', 05:11:25 INFO - 'LANGUAGE': 'en_US:en', 05:11:25 INFO - 'LOGNAME': 'cltbld', 05:11:25 INFO - 'MAIL': '/var/mail/cltbld', 05:11:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:11:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:25 INFO - 'MOZ_NO_REMOTE': '1', 05:11:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:25 INFO - 'NO_EM_RESTART': '1', 05:11:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:11:25 INFO - 'SHELL': '/bin/bash', 05:11:25 INFO - 'SHLVL': '1', 05:11:25 INFO - 'TERM': 'linux', 05:11:25 INFO - 'TMOUT': '86400', 05:11:25 INFO - 'USER': 'cltbld', 05:11:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194', 05:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:25 INFO - '_': '/tools/buildbot/bin/python'} 05:11:25 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/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 05:11:25 INFO - mozversion application_buildid: 20160218023022 05:11:25 INFO - mozversion application_changeset: 46f2f4ce7b982028bdfa56c6266aaad82be14e2b 05:11:25 INFO - mozversion application_display_name: Nightly 05:11:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:25 INFO - mozversion application_name: Firefox 05:11:25 INFO - mozversion application_remotingname: firefox 05:11:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:25 INFO - mozversion application_vendor: Mozilla 05:11:25 INFO - mozversion application_version: 47.0a1 05:11:25 INFO - mozversion platform_buildid: 20160218023022 05:11:25 INFO - mozversion platform_changeset: 46f2f4ce7b982028bdfa56c6266aaad82be14e2b 05:11:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:11:25 INFO - mozversion platform_version: 47.0a1 05:11:25 INFO - using testdate: 1455801085 05:11:25 INFO - actual date: 1455801085 05:11:25 INFO - starting webserver on 'localhost:59379' 05:11:25 INFO - SUITE-START | Running 2 tests 05:11:25 INFO - TEST-START | dromaeo_css 05:11:25 INFO - operating with platform_type : linux_ 05:11:25 INFO - Initialising browser for dromaeo_css test... 05:11:25 INFO - TEST-INFO | started process 22395 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXjVZTA/profile http://localhost:59379/getInfo.html) 05:11:30 INFO - PROCESS | 22395 | __metrics Screen width/height:1600/1200 05:11:30 INFO - PROCESS | 22395 | colorDepth:24 05:11:30 INFO - PROCESS | 22395 | Browser inner width/height: 1024/697 05:11:30 INFO - PROCESS | 22395 | __metrics 05:11:30 INFO - PROCESS | 22395 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:31 INFO - TEST-INFO | 22395: exit 0 05:11:31 INFO - Browser initialized. 05:11:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:31 INFO - TEST-INFO | started process 22488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXjVZTA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:43 INFO - PROCESS | 22488 | RSS: Main: 148312064 05:11:43 INFO - PROCESS | 22488 | 05:12:35 INFO - PROCESS | 22488 | 1455801155272 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] 05:14:43 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59379/tests/dromaeo/cssquery-ext.html) 05:14:44 INFO - PROCESS | 22488 | RSS: Main: 262221824 05:14:44 INFO - PROCESS | 22488 | 05:17:46 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-ext.html (next: http://localhost:59379/tests/dromaeo/cssquery-jquery.html) 05:17:47 INFO - PROCESS | 22488 | RSS: Main: 239251456 05:17:47 INFO - PROCESS | 22488 | 05:20:49 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59379/tests/dromaeo/cssquery-mootools.html) 05:20:50 INFO - PROCESS | 22488 | RSS: Main: 241426432 05:20:50 INFO - PROCESS | 22488 | 05:23:52 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59379/tests/dromaeo/cssquery-prototype.html) 05:23:52 INFO - PROCESS | 22488 | RSS: Main: 214990848 05:23:52 INFO - PROCESS | 22488 | 05:26:55 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59379/tests/dromaeo/cssquery-yui.html) 05:26:55 INFO - PROCESS | 22488 | RSS: Main: 221216768 05:26:55 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | Cycle 1(1): loaded http://localhost:59379/tests/dromaeo/cssquery-yui.html (next: http://localhost:59379/tests/dromaeo/cssquery-dojo.html) 05:29:58 INFO - PROCESS | 22488 | RSS: Main: 260489216 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | __start_tp_report 05:29:58 INFO - PROCESS | 22488 | _x_x_mozilla_page_load 05:29:58 INFO - PROCESS | 22488 | _x_x_mozilla_page_load_details 05:29:58 INFO - PROCESS | 22488 | |i|pagename|runs| 05:29:58 INFO - PROCESS | 22488 | |0;dojo.html;3118.3607360491096;3157.7631677624154;3189.0114064639965;3189.4259033373996;3225.741940644749;4962.454130045692;5036.471170527097;5118.795248190073;5131.12770828959;5149.768260428285;5077.822276220333;5154.123798954178;5177.715225662587;5233.267342572033;5273.129933560967;4712.740799256048;4722.622190224791;4734.976325118387;4768.998510312821;4776.617870570363;4704.67067305287;4741.525847415248;4782.187028205196;4795.712257264558;4831.613470922335;4596.54034596541;4686.03936193083;4742.4309082910095;4781.904361912742;4792.281157826319;4657.906841863144;4665.766711664403;4747.026859493795;4749.168895443284;4774.355462012619;4593.839215627437;4598.425196850394;4600.585947264763;4604.746738929358;4632.374629425019;4840.443349014838;4892.266160075981;4902.3626928499425;4911.263310503417;4928.581070609002;5447.891042179134;5477.616566840323;5560.972195139039;5563.193336966117;5568.276124103841;5527.861803454905;5537.861553461155;5541.9168712469345;5545.085060964936;5574.916376254359;5174.7671354788745;5176.301199338116;5181.404138524081;5181.5854731621375;5183.974080129613;5527.949689558971;5597.524210442158;5622.297212848394;5629.0712032514175;5699.943000570024;5429.131338985743;5454.236406903036;5457.126859702428;5460.672359658433;5462.644928079662;5459.918101228484;5506.91739623898;5506.972465137648;5509.889802203934;5516;5323.574114070865;5467.398586155519;5491.341039075336;5513.448655134534;5561.527270181999;5496.6701997880255;5498.780048798003;5499.092649712833;5504.449555044544;5506.33923929123;4211;4278.828846846153;4312.525622181557;4320.503142138631;4354.346847972829;3852.5954774748247;3852.9614703853163;3861.7489863158803;3875.3605655067163;3893.0267433141717;5130.589552835764;5130.666506677054;5133.717645529457;5147.356580427447;5149.304843846107;5260.263563101169;5486.588505862076;5523.502884740393;5556.555475561945;5608.383077861432;5039.319691841554;5084.237364395371;5092.6180536459915;5098.821541246113;5143.022825663112;4591.678582499259;4712.269598212282;4730.787114579852;4734.479207287196;4739;5646.774129034875;5677.77288908439;5698.202251684685;5698.2592263005545;5699.031164701928;5422.295101636762;5486.259354987025;5501.834944951658;5540.030494663499;5579.721013949205;5693.658380497183;5695.629784064023;5721.084626459747;5721.656700597978;5727;5236.0575096483;5422.105352616774;5422.620416570802;5451.591130665137;5473;5363.463653634605;5506.944930550643;5531.751071201886;5546.029444847055;5601.411851755507;5374.946250537601;5380.166074258496;5382.246485492113;5387.138057910715;5392.325959255093;5147.639665223398;5169.121249387538;5382.650127741685;5405.162199859028;5411.702356370437;5263.394709608444;5318;5346.812861549827;5349.598780091586;5370.087085195448;5386.865328366822;5405.945940540544;5441.646292990943;5445.59158063139;5499.725013749377;5095.363079615048;5102.821401251087;5167.199084141964;5251.238570407346;5276.07668657991 05:29:58 INFO - PROCESS | 22488 | |1;ext.html;522.8536009917223;528.5216878724755;550.9283793106896;554.2572952243994;604.8578584032751;29146.271343216402;37969.81015094924;39009.02477438062;39103.41344879829;39111;40419.191616167656;40938.181236375254;41015.58984410155;41024.17951640973;41026.17947641053;8530.70142545011;8690.08754080822;8721.215090641841;8729;8733.432326898732;8493.830123397529;8625.137486251357;8639.481631102153;8644.222020018196;8883.95558022209;8844.646214151426;8921.95539022304;8923.687670931518;8924.509151996637;8933.55332233389;8804.339674524404;8906.465612063297;8914.732558023205;8915;8917.777055573597;8768.167024132697;8914.643414263423;8934.776630584221;8946.418482798597;8947.552622368856;41106.58893411057;41272.58727412747;41569.79215103936;41621.1675766486;41649;3142.230153612357;3172.3655268946304;3212.767544186731;3240.9351812963846;3289.9835500822583;29843;30546;30708.539371909217;31037.068887933397;31136.68863311383;3521.7358698097487;3587.9282414351565;3587.9744696080943;3630.5280313559333;3735.9439608405896;205759;208365;209290;209772;210080;54786.45213547893;55672.721636392365;61814.69092654508;62154.68922655358;62156;66569.66715166393;66594;67041.32958670448;67268.6636566814;67351;15072.472463463946;15171.165585892883;15197.088174709332;15215.467458638894;15236.695266094615;11469.598564050219;11493.310401375944;11518.94240528792;11580.88419115815;12391.442385092692;19855.702164467544;20125.09437075335;20192.192312307638;20216.292429764886;20318.88246146476;7573.659185336673;7692.538447693157;7717.807054823562;7775.066991961001;7819.491733037335;882.3117967984982;922.2437601167113;932.9346945713735;1015.0103648942222;1043.12377602814;28606.141815745144;28816.279593010342;29303;29650.258743531154;29688.40623187524;1021.5556233038652;1031.257494603884;1068.257560995101;1098.785736781336;1169.3159501691437;15122.09267443957;15163.393464261526;15198;15329.968404109355;15369;323658;326267.79259348067;326862;327282;327567;51776.22335664968;52302.47697523052;52317;52327.73836130795;52371.47628523742;1205.6021512900722;1231.4520038582923;1236.2520674991501;1331.010139840944;1341.610932829488;26138.73861261363;28689;29273.414531709674;29381.85309073441;29406.852965735034;40972.38541421822;41190.38214426726;41668.374974374805;42130.73607791771;43409;212605;300477;305039;305221;306206;31901.521477178325;32871.34257314888;33070.50394244136;33088;33170.83414582912;43790;44326.11347773091;44390.55609443993;44854.3271850916;45173.77413112913;36682.72368152327;36836.447453287685;37286.44070338893;37833.62166378411;38511.6148838508;36885.63114368822;37237.069073273386;37930;38080.238395232496;38084.238315232986;36602.81698591597;36862.44706329353;37424.812875936535;37441.81279093587;37726.245475089796;32676.673233268313;34153;34162.48756268708;34382.31235375329;34484.82757586196;25500.617490737284;25520.872395637904;25676.358091047874;25679.229623111336;26065.869670651526 05:29:58 INFO - PROCESS | 22488 | |2;jquery.html;357.2693841094961;357.2729495476704;361.217963109867;363.42215876755955;364.7629041123268;13876.79184812226;13979;16659.500214993554;17284.22221000055;17697.734533981984;10805.189610779204;11108.777824443507;16191.190440477958;17066.743998839996;17097;4899.31409602655;5066.189409694432;5069.797208111671;5074.035933172704;5074.771635276422;3772.905677358074;3875.8255878485534;4958.231474121499;5386.218998245252;5592.7762889484575;5360.437154098822;5534.778608855641;5580;5583.302087239095;5587.8603034924245;5499.917501237484;5516.641418307797;5517.668939863601;5517.806876759314;5523.7238138093335;5258.0535503609335;5262.210668399733;5264.842054738364;5389.191621256804;5391.838244852622;13189.208647481182;13257.337133143305;15322.540323790305;21030.684539731916;21043.158273669036;1960.980390196094;1973.3783858084657;1997.3907958072782;2378.2746262389965;2403.315055209257;9247.907520924839;10075.143612792921;10333.22500812442;10782.73043173919;13448.865511344859;1849.1216672080654;1868.4207895552286;1872.915718792644;1912.6461604603194;1934.8839069655726;61500.69249653723;63550;63983;64298.67850660717;65032.67483662551;9881.25890558211;10137.64518241858;10545.209109316833;10555.736106597244;10766.192535559707;13937.233452160026;13969.301534923214;14103.083299585494;14113.094732211226;14132.15207087578;7907.169747176464;7949.046114466301;7949.920500794918;8019.117897031322;8022.438429310009;7738.032745906762;7749.8450030999065;7771.533707977539;7880.921190788134;7889;4238.745675259494;4566.383538222364;4568;4580.083983203373;4601.102784956901;1796.1647833757365;1821.653885761701;1830.7711536057993;1844.5296449405316;1845.9538511537319;895.3285036222833;897.9730608081768;906.7551761024487;954.737447202025;987.693814917378;12164.69588260283;15863.444779432664;16157.757633635505;16645.25096370666;17556.736648950275;866.5320726807454;887.7469921072463;950.847864341702;965.2519297544459;989.7871957529165;9434.433933963846;9768.023197680175;9836.803263934824;10064.496775161213;10222.977702229717;506616;530494;549241;549735;553692;73651.63174184095;74011.25988740043;74108.62945685237;76122.23877761263;77504;1051.942143182117;1061.6337363609543;1068.1241382066787;1068.1988508618535;1073.7154654016692;15256.237188140327;15397.30712117935;15454.845451545341;15540;15699.136547489541;35863.28273434569;36169.81915090408;36326.27347453089;36746;36893.26213475662;45524.54475455203;46017.53982460133;46263;46518.302225465966;46835.29747053865;7299.890501642373;7419.406447484296;7582.266088589718;7611.391088712779;7813.765587032398;8230.711925082593;10143.492825358555;10687.51906164209;11063.889361106287;11311.604093856675;10555.525001374803;10593.09958653523;10685.483870967606;10745.409002504937;11092.611758588411;10678.466076695979;10795.244332896622;10830.241883068109;10839.945800270949;10885.074768644754;11017.724556886142;11017.889821101686;11031.669049928514;11040.779184416428;11149.944250278697;7810.921890781019;7870.9606451967375;7895.092064412666;7906.248906353887;7924.84150317002;10439;10678.519466624177;10683;10874.293170943864;10984 05:29:58 INFO - PROCESS | 22488 | |3;mootools.html;1321.3987635625792;1445.9421623135074;1446.8119144511209;1587.4047232287892;1768.699321115411;6716.294789047147;7315.158756742976;7480.551166929974;7487.176410594844;7488.850222995537;7233.927660723391;7420.146683131442;7421.851562968737;7423.888641670365;7431.851362972738;1894.9905250473728;1918.7409699690572;2101.590189912964;2127.7340332458443;2190.145843121184;2281.7946384825364;2288.96566551501;2289.3360925331717;2291.541691661666;2295.0704964489323;2182.6180418426793;2255.23322070496;2256.029907139929;2258.2660635293514;2261.536385041071;2183.246779860953;2194.122351059581;2206.172685243034;2218.966715499269;2221.544583360407;2165.7184566006317;2170.522485053286;2196.7034450349156;2197.4286685461734;2198.6482162854027;7653.846923061507;7727.574983375912;7731.072271327421;7732.961335193344;7735.419843511759;4548.295014272793;4624.190766615829;4646.326282689025;4651.348811166439;4663.067386522709;2819.1401622505127;2874.9137525874257;2915.1546051644996;2928.1508362574828;2942.8528573571234;944.9055094490565;948.4262021476976;951.0251991708485;953.0069010844609;989.9950500247525;10320.174386049099;10322.638707645272;10348.068673819393;10349.948250258776;10371.79256414875;4096.242195193899;4109.753414795062;4159.147374788161;4172.332426811696;4175.91648167035;8926;8945.910540894507;8946.060663630225;8950.060243674321;9014.729558113268;4655.534446555385;4658.34783130362;4679.485256621769;4685.226937555333;4693.647976401783;4275.444192254987;4276.828926842892;4278.89302767427;4284.528701842794;4286.507051689034;3297.7032067113596;3556.5020897074432;3571.053670777246;3578.3916734155255;3588.6052534221217;1156.2888823373564;1213.3023511480933;1215.155466950461;1215.7811593913004;1220.5483970930813;1301.2452777389092;1303.1920209470188;1315.0991570774052;1315.4540865540694;1325.648703093681;7038.753643622448;7064.540804847668;7146.178189508169;7147.070880785464;7148.177959534616;1111.4553868604326;1117.2962226640159;1121.9439028048564;1127.3968426891574;1134.0077432246785;5749.9712501437225;5849.2103566018895;5849.736761845727;5851.473367396955;5855;8944.642214311485;8978.640854365884;9107.043760405195;9214;9262.073792620818;8995.505247211466;9147.0852914708;9151.130642588943;9170.220531254785;9170.266378689688;7043.119610048744;7131.286871312931;7237.927620723831;7248.238934911864;7259.346658800628;6861.176658800776;6970.407515361048;6985.336393042653;6991.965040174767;7005.964970175117;7989.440739148204;8310.83378332442;8425.95787021061;8433.915660843559;8464.66141354339;7911.367090632851;7934.20657934202;7965.084015338311;8036.116027237116;8044.115147333671;6473.805785826245;6561.671916404256;6666.26671066192;6677.532572720057;6682.431993280626;6388.776392826415;6990.2660220678135;7183.102112235971;7206.351428371472;7214.603196824225;6800.863982720417;6931.306869313028;7016.894746578703;7029.156501219886;7115.53749006313;6931.306869313028;6942.375186233263;6958.921367188094;6967.09427774386;7003.789886303419;6988.37104660583;7036.824079398056;7053.682584283617;7060;7066.681999310146;6057.939860524479;6127.417895299939;6156.815295541141;6166.753329866755;6192.876142477216;6259.061140828912;6278.15244941927;6294.8111556653375;6296.622202667671;6305.96847015762 05:29:58 INFO - PROCESS | 22488 | |4;prototype.html;325.9185203699075;330.5867665418227;333.79972016789924;338.90171850163455;343.18835952971233;5750.971245143768;5870.765169393225;5893.646381217125;5950.10748387742;5973.223480947481;5731.083026715726;5800.65196088235;5800.9129863051985;5818.389069147742;5825.330087039981;4580.9541904580865;4586.357909892609;4588.197065513538;4595.701279416844;4596.448426188862;4363.410939523172;4472.977635111836;4479.977600112011;4487.5063742988405;4586.724796512203;4436.600705936465;4494.460664720238;4511.3233015047845;4519.79660915258;4524.592786649201;4522.932156017662;4536.478304994918;4537.9773101134615;4545.136424079415;4548.044910568785;4010.5187377514885;4011.498562679665;4023.4970628671417;4031.1333063391216;4031.2743706132883;5460.590455715837;5631.746571404296;5638.577106716972;5655.4061823508355;5668.121441176583;5294.629375943686;5305.522502974751;5306.230596563515;5308.389535203462;5313.229581710631;5966.075258334965;6296.338884417116;6300.369963003709;6301.180846489973;6301.87396252077;4345.500267469219;4422.336649502568;4445.177642136183;4451.532589078132;4466.1067786442845;6414.294427612959;6505.512086593477;6522.608643481359;6523.641199734013;6524.151860258136;4532.9320060199125;4538.160440318552;4539.114872599877;4545.409096817459;4549.385832912581;4513.864584062418;4602.838900638461;4617.884552886205;4618.907621847544;4624.884377890579;5255.159174532133;5265.578753699695;5267.367915850046;5269.446708095671;5271.235670827708;6253.437190652863;6274.152989346379;6282.277538083087;6289;6297.748090076438;1599.4082189589926;1621.578389618684;1624.8781341399442;1627.9267432965546;1630.5515983104503;1094.8412480190327;1100.4112799652148;1101.9779604408027;1112.9276597021167;1127.5997021057572;5919.3192782829665;5921.970390148108;5925.051991681396;5928.584999050025;5930.55520835939;6429.6142231466265;6442.806715798533;6445.355464453517;6446.4520515756685;6448.548601597843;5828.154917536934;5872.530197584183;5921.911171332434;5927.614705044159;5929.169916211734;3400.846961886721;3464.082018265162;3465.358908601917;3478.9304213916084;3482.9825850870584;6676.365745254193;6704.899426508607;6716.1604799400075;6720.798376048726;6734.797956061326;6549.476041916635;6568.868622627616;6578.27638959714;6585.934140658628;6591.505637077238;6515.413612774873;6688;6714.060031595581;6717.429018533382;6720.495962802712;6234.942468985133;6348.650824204713;6425.518086143465;6433.260175079926;6435.03474478832;6289.088082228142;6381.776637817654;6397.744090236339;6430.324815894263;6433.839154021187;6670.199576050905;6690.029945657755;6708.127943367526;6708.8993665094085;6714.83212919681;4266.850660226877;4549.5905368517;4553.521880202531;4555.430571178603;4556.2254416748565;6476.805695829133;6478.805635830932;6488.12410324619;6498.415142637185;6503.382178693017;6285.182926219562;6288.5598008138995;6292.779752708633;6294.842628934313;6299.118123462627;6181.474574661204;6232.875342493216;6281.340459251713;6282.089097080989;6289.937100628935;6182.28903676083;6186.597871138361;6189.6286222826775;6194.535409844189;6200.3179650237535;6303.936960630335;6321.304656487875;6335.239771227482;6337.04944258365;6341.334159913143;6070.726817293144;6177.938220617736;6182.227221597301;6182.227221597301;6183.041628547582 05:29:58 INFO - PROCESS | 22488 | |5;yui.html;750.9849803003937;760.4182800157879;800.5270302643139;820.5199958024556;829.1294141151793;13481.123726957741;13775.862241377596;13786.448542058331;13788;13803.861961380384;13058.673533161676;13110.475580976774;13129.540466083665;13133.802992955114;13150.408231629575;673.4141297071554;816.3958670583755;820.3724151024442;840.970566030189;841.8021764885247;833.3957880536593;837.5895811052571;837.7905523619095;839.8320335932807;840.487302745328;710.3535782437982;878.7495563764328;879.9428037177563;880.0143838900441;880.5685214245005;704.781517729503;705.206642527157;705.8023753349071;845.3237410071918;861.6165806216236;633.0188208277152;633.4299130782287;633.7813454358239;634.0774173577433;634.815903388017;13289.269090200036;13298.468061277537;13415.932920335434;13428.664283392896;13443.193408395528;12808.359582020956;13058.804117938238;13182.868171318356;13219.471221151143;13333.466661333536;10543.31468454548;10715.678529644045;10748.516316765765;10879;10898.891011089867;3621.746477746559;3649.069487280753;3670.743047986642;3672.632736726306;3777.263433630443;48735.75632121852;48817.51182488165;48891.511084889054;49018;49132.75433622845;10399;10431.68704938853;10482.47587620616;10630.787384252271;11024.393658348707;18875;18905.243790248234;18910.149043293084;18928.43214703561;18938.14778334978;7427.740029099064;7637.274458926504;7653.923460765321;7743.690252389954;7784.649690763929;4240.766757828349;4253.914921701548;4328.7402755834755;4445.177642136216;4586.72479651222;3053.8931137410527;3072.7080927311868;3083.152133163353;3098.98450507746;3100.98449507751;561.6068751873705;565.104309669179;565.3159676791129;568.6843801690019;588.65563645268;566.6175331651119;694.0907411291224;699.2729937996506;701.8561194955022;709.2481969112757;9269.16577508014;9534.856977145348;9568.146096849066;9638.228941684649;9759.756006099762;549.5630973376176;580.7996241296746;619.6096459230656;709.2694524639629;738.9298016688406;4220.683448741357;4247.936280955788;4333.15503476819;4460.8661740147845;4467.73193608378;56762;56929;57214;58291;58713;50996;52350.21474677883;52726.209106863425;52778.20832687513;52848.20727689088;46009.30986035212;46090.769546152056;46444.535554644695;46919.5308046922;47340;8841.292696584387;8873.600687969187;8888.644454222018;8889.866652000355;8945.664728422878;34106.48840267448;34143.14642133967;34588.82705586456;34613;34897.47653785144;41428.58571414247;41803.37294940639;44996;46321.76839115783;46426.76786616045;10401.479926003518;10466.110380617429;10723.624673136403;10803.621873234399;10888.346699198073;10156.644517441853;10436.165106791286;10772.676819695422;11789.882101179222;11847.229930054518;10635.14918806478;10921;11020.228583999364;11499.597514086967;11905.345206013752;10574.312669676447;10591.576336946437;10897.291676041032;11151.275167114112;11605.6518304451;9755.9024409755;9760.755981100529;9865.852012219679;9896.10935015852;11177.944110279397;9446.433214006907;9530.237580993642;9668.56491457872;9849;9853.408795472295;9181;9246.398984066014;9647.1317581418;9975.750606234902;10308.866823012944 05:29:58 INFO - PROCESS | 22488 | __end_tp_report 05:29:58 INFO - PROCESS | 22488 | __start_cc_report 05:29:58 INFO - PROCESS | 22488 | _x_x_mozilla_cycle_collect,802 05:29:58 INFO - PROCESS | 22488 | __end_cc_report 05:29:58 INFO - PROCESS | 22488 | __startTimestamp1455802198688__endTimestamp 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | ------- Summary: start ------- 05:29:58 INFO - PROCESS | 22488 | Number of tests: 6 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#0] dojo.html Cycles:165 Average:5112.33 Median:5263.39 stddev:545.31 (10.4%) stddev-sans-first:524.06 05:29:58 INFO - PROCESS | 22488 | Values: 3118.4 3157.8 3189.0 3189.4 3225.7 4962.5 5036.5 5118.8 5131.1 5149.8 5077.8 5154.1 5177.7 5233.3 5273.1 4712.7 4722.6 4735.0 4769.0 4776.6 4704.7 4741.5 4782.2 4795.7 4831.6 4596.5 4686.0 4742.4 4781.9 4792.3 4657.9 4665.8 4747.0 4749.2 4774.4 4593.8 4598.4 4600.6 4604.7 4632.4 4840.4 4892.3 4902.4 4911.3 4928.6 5447.9 5477.6 5561.0 5563.2 5568.3 5527.9 5537.9 5541.9 5545.1 5574.9 5174.8 5176.3 5181.4 5181.6 5184.0 5527.9 5597.5 5622.3 5629.1 5699.9 5429.1 5454.2 5457.1 5460.7 5462.6 5459.9 5506.9 5507.0 5509.9 5516.0 5323.6 5467.4 5491.3 5513.4 5561.5 5496.7 5498.8 5499.1 5504.4 5506.3 4211.0 4278.8 4312.5 4320.5 4354.3 3852.6 3853.0 3861.7 3875.4 3893.0 5130.6 5130.7 5133.7 5147.4 5149.3 5260.3 5486.6 5523.5 5556.6 5608.4 5039.3 5084.2 5092.6 5098.8 5143.0 4591.7 4712.3 4730.8 4734.5 4739.0 5646.8 5677.8 5698.2 5698.3 5699.0 5422.3 5486.3 5501.8 5540.0 5579.7 5693.7 5695.6 5721.1 5721.7 5727.0 5236.1 5422.1 5422.6 5451.6 5473.0 5363.5 5506.9 5531.8 5546.0 5601.4 5374.9 5380.2 5382.2 5387.1 5392.3 5147.6 5169.1 5382.7 5405.2 5411.7 5263.4 5318.0 5346.8 5349.6 5370.1 5386.9 5405.9 5441.6 5445.6 5499.7 5095.4 5102.8 5167.2 5251.2 5276.1 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#1] ext.html Cycles:180 Average:45079.66 Median:36874.04 stddev:72925.79 (197.8%) stddev-sans-first:73053.63 05:29:58 INFO - PROCESS | 22488 | Values: 522.9 528.5 550.9 554.3 604.9 29146.3 37969.8 39009.0 39103.4 39111.0 40419.2 40938.2 41015.6 41024.2 41026.2 8530.7 8690.1 8721.2 8729.0 8733.4 8493.8 8625.1 8639.5 8644.2 8884.0 8844.6 8922.0 8923.7 8924.5 8933.6 8804.3 8906.5 8914.7 8915.0 8917.8 8768.2 8914.6 8934.8 8946.4 8947.6 41106.6 41272.6 41569.8 41621.2 41649.0 3142.2 3172.4 3212.8 3240.9 3290.0 29843.0 30546.0 30708.5 31037.1 31136.7 3521.7 3587.9 3588.0 3630.5 3735.9 205759.0 208365.0 209290.0 209772.0 210080.0 54786.5 55672.7 61814.7 62154.7 62156.0 66569.7 66594.0 67041.3 67268.7 67351.0 15072.5 15171.2 15197.1 15215.5 15236.7 11469.6 11493.3 11518.9 11580.9 12391.4 19855.7 20125.1 20192.2 20216.3 20318.9 7573.7 7692.5 7717.8 7775.1 7819.5 882.3 922.2 932.9 1015.0 1043.1 28606.1 28816.3 29303.0 29650.3 29688.4 1021.6 1031.3 1068.3 1098.8 1169.3 15122.1 15163.4 15198.0 15330.0 15369.0 323658.0 326267.8 326862.0 327282.0 327567.0 51776.2 52302.5 52317.0 52327.7 52371.5 1205.6 1231.5 1236.3 1331.0 1341.6 26138.7 28689.0 29273.4 29381.9 29406.9 40972.4 41190.4 41668.4 42130.7 43409.0 212605.0 300477.0 305039.0 305221.0 306206.0 31901.5 32871.3 33070.5 33088.0 33170.8 43790.0 44326.1 44390.6 44854.3 45173.8 36682.7 36836.4 37286.4 37833.6 38511.6 36885.6 37237.1 37930.0 38080.2 38084.2 36602.8 36862.4 37424.8 37441.8 37726.2 32676.7 34153.0 34162.5 34382.3 34484.8 25500.6 25520.9 25676.4 25679.2 26065.9 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#2] jquery.html Cycles:180 Average:27979.44 Median:18345.52 stddev:88034.04 (479.9%) stddev-sans-first:88256.56 05:29:58 INFO - PROCESS | 22488 | Values: 357.3 357.3 361.2 363.4 364.8 13876.8 13979.0 16659.5 17284.2 17697.7 10805.2 11108.8 16191.2 17066.7 17097.0 4899.3 5066.2 5069.8 5074.0 5074.8 3772.9 3875.8 4958.2 5386.2 5592.8 5360.4 5534.8 5580.0 5583.3 5587.9 5499.9 5516.6 5517.7 5517.8 5523.7 5258.1 5262.2 5264.8 5389.2 5391.8 13189.2 13257.3 15322.5 21030.7 21043.2 1961.0 1973.4 1997.4 2378.3 2403.3 9247.9 10075.1 10333.2 10782.7 13448.9 1849.1 1868.4 1872.9 1912.6 1934.9 61500.7 63550.0 63983.0 64298.7 65032.7 9881.3 10137.6 10545.2 10555.7 10766.2 13937.2 13969.3 14103.1 14113.1 14132.2 7907.2 7949.0 7949.9 8019.1 8022.4 7738.0 7749.8 7771.5 7880.9 7889.0 4238.7 4566.4 4568.0 4580.1 4601.1 1796.2 1821.7 1830.8 1844.5 1846.0 895.3 898.0 906.8 954.7 987.7 12164.7 15863.4 16157.8 16645.3 17556.7 866.5 887.7 950.8 965.3 989.8 9434.4 9768.0 9836.8 10064.5 10223.0 506616.0 530494.0 549241.0 549735.0 553692.0 73651.6 74011.3 74108.6 76122.2 77504.0 1051.9 1061.6 1068.1 1068.2 1073.7 15256.2 15397.3 15454.8 15540.0 15699.1 35863.3 36169.8 36326.3 36746.0 36893.3 45524.5 46017.5 46263.0 46518.3 46835.3 7299.9 7419.4 7582.3 7611.4 7813.8 8230.7 10143.5 10687.5 11063.9 11311.6 10555.5 10593.1 10685.5 10745.4 11092.6 10678.5 10795.2 10830.2 10839.9 10885.1 11017.7 11017.9 11031.7 11040.8 11149.9 7810.9 7871.0 7895.1 7906.2 7924.8 10439.0 10678.5 10683.0 10874.3 10984.0 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#3] mootools.html Cycles:180 Average:5320.90 Median:6268.61 stddev:2732.24 (43.6%) stddev-sans-first:2723.37 05:29:58 INFO - PROCESS | 22488 | Values: 1321.4 1445.9 1446.8 1587.4 1768.7 6716.3 7315.2 7480.6 7487.2 7488.9 7233.9 7420.1 7421.9 7423.9 7431.9 1895.0 1918.7 2101.6 2127.7 2190.1 2281.8 2289.0 2289.3 2291.5 2295.1 2182.6 2255.2 2256.0 2258.3 2261.5 2183.2 2194.1 2206.2 2219.0 2221.5 2165.7 2170.5 2196.7 2197.4 2198.6 7653.8 7727.6 7731.1 7733.0 7735.4 4548.3 4624.2 4646.3 4651.3 4663.1 2819.1 2874.9 2915.2 2928.2 2942.9 944.9 948.4 951.0 953.0 990.0 10320.2 10322.6 10348.1 10349.9 10371.8 4096.2 4109.8 4159.1 4172.3 4175.9 8926.0 8945.9 8946.1 8950.1 9014.7 4655.5 4658.3 4679.5 4685.2 4693.6 4275.4 4276.8 4278.9 4284.5 4286.5 3297.7 3556.5 3571.1 3578.4 3588.6 1156.3 1213.3 1215.2 1215.8 1220.5 1301.2 1303.2 1315.1 1315.5 1325.6 7038.8 7064.5 7146.2 7147.1 7148.2 1111.5 1117.3 1121.9 1127.4 1134.0 5750.0 5849.2 5849.7 5851.5 5855.0 8944.6 8978.6 9107.0 9214.0 9262.1 8995.5 9147.1 9151.1 9170.2 9170.3 7043.1 7131.3 7237.9 7248.2 7259.3 6861.2 6970.4 6985.3 6992.0 7006.0 7989.4 8310.8 8426.0 8433.9 8464.7 7911.4 7934.2 7965.1 8036.1 8044.1 6473.8 6561.7 6666.3 6677.5 6682.4 6388.8 6990.3 7183.1 7206.4 7214.6 6800.9 6931.3 7016.9 7029.2 7115.5 6931.3 6942.4 6958.9 6967.1 7003.8 6988.4 7036.8 7053.7 7060.0 7066.7 6057.9 6127.4 6156.8 6166.8 6192.9 6259.1 6278.2 6294.8 6296.6 6306.0 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#4] prototype.html Cycles:180 Average:5249.27 Median:5920.62 stddev:1562.08 (26.4%) stddev-sans-first:1522.12 05:29:58 INFO - PROCESS | 22488 | Values: 325.9 330.6 333.8 338.9 343.2 5751.0 5870.8 5893.6 5950.1 5973.2 5731.1 5800.7 5800.9 5818.4 5825.3 4581.0 4586.4 4588.2 4595.7 4596.4 4363.4 4473.0 4480.0 4487.5 4586.7 4436.6 4494.5 4511.3 4519.8 4524.6 4522.9 4536.5 4538.0 4545.1 4548.0 4010.5 4011.5 4023.5 4031.1 4031.3 5460.6 5631.7 5638.6 5655.4 5668.1 5294.6 5305.5 5306.2 5308.4 5313.2 5966.1 6296.3 6300.4 6301.2 6301.9 4345.5 4422.3 4445.2 4451.5 4466.1 6414.3 6505.5 6522.6 6523.6 6524.2 4532.9 4538.2 4539.1 4545.4 4549.4 4513.9 4602.8 4617.9 4618.9 4624.9 5255.2 5265.6 5267.4 5269.4 5271.2 6253.4 6274.2 6282.3 6289.0 6297.7 1599.4 1621.6 1624.9 1627.9 1630.6 1094.8 1100.4 1102.0 1112.9 1127.6 5919.3 5922.0 5925.1 5928.6 5930.6 6429.6 6442.8 6445.4 6446.5 6448.5 5828.2 5872.5 5921.9 5927.6 5929.2 3400.8 3464.1 3465.4 3478.9 3483.0 6676.4 6704.9 6716.2 6720.8 6734.8 6549.5 6568.9 6578.3 6585.9 6591.5 6515.4 6688.0 6714.1 6717.4 6720.5 6234.9 6348.7 6425.5 6433.3 6435.0 6289.1 6381.8 6397.7 6430.3 6433.8 6670.2 6690.0 6708.1 6708.9 6714.8 4266.9 4549.6 4553.5 4555.4 4556.2 6476.8 6478.8 6488.1 6498.4 6503.4 6285.2 6288.6 6292.8 6294.8 6299.1 6181.5 6232.9 6281.3 6282.1 6289.9 6182.3 6186.6 6189.6 6194.5 6200.3 6303.9 6321.3 6335.2 6337.0 6341.3 6070.7 6177.9 6182.2 6182.2 6183.0 05:29:58 INFO - PROCESS | 22488 | 05:29:58 INFO - PROCESS | 22488 | [#5] yui.html Cycles:180 Average:13862.32 Median:47129.77 stddev:16037.78 (34.0%) stddev-sans-first:16052.55 05:29:58 INFO - PROCESS | 22488 | Values: 751.0 760.4 800.5 820.5 829.1 13481.1 13775.9 13786.4 13788.0 13803.9 13058.7 13110.5 13129.5 13133.8 13150.4 673.4 816.4 820.4 841.0 841.8 833.4 837.6 837.8 839.8 840.5 710.4 878.7 879.9 880.0 880.6 704.8 705.2 705.8 845.3 861.6 633.0 633.4 633.8 634.1 634.8 13289.3 13298.5 13415.9 13428.7 13443.2 12808.4 13058.8 13182.9 13219.5 13333.5 10543.3 10715.7 10748.5 10879.0 10898.9 3621.7 3649.1 3670.7 3672.6 3777.3 48735.8 48817.5 48891.5 49018.0 49132.8 10399.0 10431.7 10482.5 10630.8 11024.4 18875.0 18905.2 18910.1 18928.4 18938.1 7427.7 7637.3 7653.9 7743.7 7784.6 4240.8 4253.9 4328.7 4445.2 4586.7 3053.9 3072.7 3083.2 3099.0 3101.0 561.6 565.1 565.3 568.7 588.7 566.6 694.1 699.3 701.9 709.2 9269.2 9534.9 9568.1 9638.2 9759.8 549.6 580.8 619.6 709.3 738.9 4220.7 4247.9 4333.2 4460.9 4467.7 56762.0 56929.0 57214.0 58291.0 58713.0 50996.0 52350.2 52726.2 52778.2 52848.2 46009.3 46090.8 46444.5 46919.5 47340.0 8841.3 8873.6 8888.6 8889.9 8945.7 34106.5 34143.1 34588.8 34613.0 34897.5 41428.6 41803.4 44996.0 46321.8 46426.8 10401.5 10466.1 10723.6 10803.6 10888.3 10156.6 10436.2 10772.7 11789.9 11847.2 10635.1 10921.0 11020.2 11499.6 11905.3 10574.3 10591.6 10897.3 11151.3 11605.7 9755.9 9760.8 9865.9 9896.1 11177.9 9446.4 9530.2 9668.6 9849.0 9853.4 9181.0 9246.4 9647.1 9975.8 10308.9 05:29:58 INFO - PROCESS | 22488 | -------- Summary: end -------- 05:29:58 INFO - PROCESS | 22488 | 05:29:59 INFO - TEST-INFO | 22488: exit 0 05:29:59 INFO - TEST-OK | dromaeo_css | took 1113585ms 05:29:59 INFO - TEST-START | kraken 05:29:59 INFO - operating with platform_type : linux_ 05:29:59 INFO - Initialising browser for kraken test... 05:29:59 INFO - TEST-INFO | started process 22678 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPkXoEN/profile http://localhost:59379/getInfo.html) 05:30:03 INFO - PROCESS | 22678 | __metrics Screen width/height:1600/1200 05:30:03 INFO - PROCESS | 22678 | colorDepth:24 05:30:03 INFO - PROCESS | 22678 | Browser inner width/height: 1024/697 05:30:03 INFO - PROCESS | 22678 | __metrics 05:30:04 INFO - PROCESS | 22678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:05 INFO - TEST-INFO | 22678: exit 0 05:30:05 INFO - Browser initialized. 05:30:05 INFO - Running cycle 1/1 for kraken test... 05:30:05 INFO - TEST-INFO | started process 22762 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPkXoEN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:16 INFO - PROCESS | 22762 | RSS: Main: 148017152 05:30:16 INFO - PROCESS | 22762 | 05:30:19 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59379/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:19 INFO - PROCESS | 22762 | RSS: Main: 190672896 05:30:19 INFO - PROCESS | 22762 | 05:30:22 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59379/tests/kraken/driver.html?testName=audio-dft) 05:30:23 INFO - PROCESS | 22762 | RSS: Main: 182386688 05:30:23 INFO - PROCESS | 22762 | 05:30:26 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59379/tests/kraken/driver.html?testName=audio-fft) 05:30:26 INFO - PROCESS | 22762 | RSS: Main: 165609472 05:30:26 INFO - PROCESS | 22762 | 05:30:28 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59379/tests/kraken/driver.html?testName=audio-oscillator) 05:30:29 INFO - PROCESS | 22762 | RSS: Main: 166674432 05:30:29 INFO - PROCESS | 22762 | 05:30:31 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:32 INFO - PROCESS | 22762 | RSS: Main: 169803776 05:30:32 INFO - PROCESS | 22762 | 05:30:35 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59379/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:35 INFO - PROCESS | 22762 | RSS: Main: 169279488 05:30:35 INFO - PROCESS | 22762 | 05:30:39 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59379/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:39 INFO - PROCESS | 22762 | RSS: Main: 170979328 05:30:39 INFO - PROCESS | 22762 | 05:30:42 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59379/tests/kraken/driver.html?testName=json-parse-financial) 05:30:42 INFO - PROCESS | 22762 | RSS: Main: 171077632 05:30:42 INFO - PROCESS | 22762 | 05:30:44 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:45 INFO - PROCESS | 22762 | RSS: Main: 185286656 05:30:45 INFO - PROCESS | 22762 | 05:30:46 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:47 INFO - PROCESS | 22762 | RSS: Main: 180260864 05:30:47 INFO - PROCESS | 22762 | 05:30:49 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:50 INFO - PROCESS | 22762 | RSS: Main: 192663552 05:30:50 INFO - PROCESS | 22762 | 05:30:52 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:53 INFO - PROCESS | 22762 | RSS: Main: 197361664 05:30:53 INFO - PROCESS | 22762 | 05:30:55 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:56 INFO - PROCESS | 22762 | RSS: Main: 196141056 05:30:56 INFO - PROCESS | 22762 | 05:30:57 INFO - PROCESS | 22762 | Cycle 1(1): loaded http://localhost:59379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59379/tests/kraken/driver.html?testName=ai-astar) 05:30:58 INFO - PROCESS | 22762 | RSS: Main: 258310144 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | __start_tp_report 05:30:58 INFO - PROCESS | 22762 | _x_x_mozilla_page_load 05:30:58 INFO - PROCESS | 22762 | _x_x_mozilla_page_load_details 05:30:58 INFO - PROCESS | 22762 | |i|pagename|runs| 05:30:58 INFO - PROCESS | 22762 | |0;ai-astar;113;112;106;112;112;111;102;111;110;112 05:30:58 INFO - PROCESS | 22762 | |1;audio-beat-detection;150;136;154;192;127;149;157;131;166;129 05:30:58 INFO - PROCESS | 22762 | |2;audio-dft;160;160;160;161;160;162;159;162;161;163 05:30:58 INFO - PROCESS | 22762 | |3;audio-fft;76;74;104;94;74;73;74;110;97;84 05:30:58 INFO - PROCESS | 22762 | |4;audio-oscillator;95;96;140;94;95;97;140;96;96;143 05:30:58 INFO - PROCESS | 22762 | |5;imaging-gaussian-blur;120;116;116;115;116;115;115;115;116;116 05:30:58 INFO - PROCESS | 22762 | |6;imaging-darkroom;146;145;145;145;146;146;145;145;146;146 05:30:58 INFO - PROCESS | 22762 | |7;imaging-desaturate;98;96;96;96;96;96;96;97;97;96 05:30:58 INFO - PROCESS | 22762 | |8;json-parse-financial;56;55;56;57;56;56;58;65;55;63 05:30:58 INFO - PROCESS | 22762 | |9;json-stringify-tinderbox;66;67;67;67;67;68;67;70;69;68 05:30:58 INFO - PROCESS | 22762 | |10;stanford-crypto-aes;81;81;82;82;85;89;82;81;82;83 05:30:58 INFO - PROCESS | 22762 | |11;stanford-crypto-ccm;117;115;114;115;115;120;126;114;114;122 05:30:58 INFO - PROCESS | 22762 | |12;stanford-crypto-pbkdf2;142;155;153;153;161;142;152;151;151;153 05:30:58 INFO - PROCESS | 22762 | |13;stanford-crypto-sha256-iterative;71;68;67;69;67;66;71;70;68;68 05:30:58 INFO - PROCESS | 22762 | __end_tp_report 05:30:58 INFO - PROCESS | 22762 | __start_cc_report 05:30:58 INFO - PROCESS | 22762 | _x_x_mozilla_cycle_collect,962 05:30:58 INFO - PROCESS | 22762 | __end_cc_report 05:30:58 INFO - PROCESS | 22762 | __startTimestamp1455802258227__endTimestamp 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | ------- Summary: start ------- 05:30:58 INFO - PROCESS | 22762 | Number of tests: 14 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.45 (3.1%) stddev-sans-first:3.49 05:30:58 INFO - PROCESS | 22762 | Values: 113.0 112.0 106.0 112.0 112.0 111.0 102.0 111.0 110.0 112.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:152.00 stddev:20.01 (13.2%) stddev-sans-first:21.22 05:30:58 INFO - PROCESS | 22762 | Values: 150.0 136.0 154.0 192.0 127.0 149.0 157.0 131.0 166.0 129.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 05:30:58 INFO - PROCESS | 22762 | Values: 160.0 160.0 160.0 161.0 160.0 162.0 159.0 162.0 161.0 163.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#3] audio-fft Cycles:10 Average:86.00 Median:75.00 stddev:14.10 (18.8%) stddev-sans-first:14.49 05:30:58 INFO - PROCESS | 22762 | Values: 76.0 74.0 104.0 94.0 74.0 73.0 74.0 110.0 97.0 84.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.50 stddev:21.97 (23.0%) stddev-sans-first:22.70 05:30:58 INFO - PROCESS | 22762 | Values: 95.0 96.0 140.0 94.0 95.0 97.0 140.0 96.0 96.0 143.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 05:30:58 INFO - PROCESS | 22762 | Values: 120.0 116.0 116.0 115.0 116.0 115.0 115.0 115.0 116.0 116.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:30:58 INFO - PROCESS | 22762 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 05:30:58 INFO - PROCESS | 22762 | Values: 98.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.50 stddev:3.47 (6.1%) stddev-sans-first:3.62 05:30:58 INFO - PROCESS | 22762 | Values: 56.0 55.0 56.0 57.0 56.0 56.0 58.0 65.0 55.0 63.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.09 05:30:58 INFO - PROCESS | 22762 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 67.0 70.0 69.0 68.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.49 (3.0%) stddev-sans-first:2.55 05:30:58 INFO - PROCESS | 22762 | Values: 81.0 81.0 82.0 82.0 85.0 89.0 82.0 81.0 82.0 83.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:116.00 stddev:4.13 (3.6%) stddev-sans-first:4.38 05:30:58 INFO - PROCESS | 22762 | Values: 117.0 115.0 114.0 115.0 115.0 120.0 126.0 114.0 114.0 122.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.00 stddev:5.68 (3.7%) stddev-sans-first:4.92 05:30:58 INFO - PROCESS | 22762 | Values: 142.0 155.0 153.0 153.0 161.0 142.0 152.0 151.0 151.0 153.0 05:30:58 INFO - PROCESS | 22762 | 05:30:58 INFO - PROCESS | 22762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.72 (2.5%) stddev-sans-first:1.56 05:30:58 INFO - PROCESS | 22762 | Values: 71.0 68.0 67.0 69.0 67.0 66.0 71.0 70.0 68.0 68.0 05:30:58 INFO - PROCESS | 22762 | -------- Summary: end -------- 05:30:58 INFO - PROCESS | 22762 | 05:30:59 INFO - TEST-INFO | 22762: exit 0 05:30:59 INFO - TEST-OK | kraken | took 60041ms 05:30:59 INFO - SUITE-END | took 1173s 05:30:59 INFO - Completed test suite (00:19:33) 05:30:59 INFO - Working with test: dromaeo_css 05:30:59 INFO - Generating results file: dromaeo_css 05:30:59 INFO - Working with test: kraken 05:30:59 INFO - Generating results file: kraken 05:30:59 INFO - javascript benchmark 05:30:59 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:30:59 INFO - process_Request line: dromaeo_css 6844.57 graph.html#tests=[[72,201,35]] 05:30:59 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:59 INFO - process_Request line: kraken 1518.20 graph.html#tests=[[232,201,35]] 05:30:59 INFO - RETURN: dromaeo_css: 6844.57 05:30:59 INFO - RETURN: kraken: 1518.20 05:30:59 INFO - javascript benchmark 05:30:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.3607360491096, 3157.7631677624154, 3189.0114064639965, 3189.4259033373996, 3225.741940644749, 4962.454130045692, 5036.471170527097, 5118.795248190073, 5131.12770828959, 5149.768260428285, 5077.822276220333, 5154.123798954178, 5177.715225662587, 5233.267342572033, 5273.129933560967, 4712.740799256048, 4722.622190224791, 4734.976325118387, 4768.998510312821, 4776.617870570363, 4704.67067305287, 4741.525847415248, 4782.187028205196, 4795.712257264558, 4831.613470922335, 4596.54034596541, 4686.03936193083, 4742.4309082910095, 4781.904361912742, 4792.281157826319, 4657.906841863144, 4665.766711664403, 4747.026859493795, 4749.168895443284, 4774.355462012619, 4593.839215627437, 4598.425196850394, 4600.585947264763, 4604.746738929358, 4632.374629425019, 4840.443349014838, 4892.266160075981, 4902.3626928499425, 4911.263310503417, 4928.581070609002, 5447.891042179134, 5477.616566840323, 5560.972195139039, 5563.193336966117, 5568.276124103841, 5527.861803454905, 5537.861553461155, 5541.9168712469345, 5545.085060964936, 5574.916376254359, 5174.7671354788745, 5176.301199338116, 5181.404138524081, 5181.5854731621375, 5183.974080129613, 5527.949689558971, 5597.524210442158, 5622.297212848394, 5629.0712032514175, 5699.943000570024, 5429.131338985743, 5454.236406903036, 5457.126859702428, 5460.672359658433, 5462.644928079662, 5459.918101228484, 5506.91739623898, 5506.972465137648, 5509.889802203934, 5516.0, 5323.574114070865, 5467.398586155519, 5491.341039075336, 5513.448655134534, 5561.527270181999, 5496.6701997880255, 5498.780048798003, 5499.092649712833, 5504.449555044544, 5506.33923929123, 4211.0, 4278.828846846153, 4312.525622181557, 4320.503142138631, 4354.346847972829, 3852.5954774748247, 3852.9614703853163, 3861.7489863158803, 3875.3605655067163, 3893.0267433141717, 5130.589552835764, 5130.666506677054, 5133.717645529457, 5147.356580427447, 5149.304843846107, 5260.263563101169, 5486.588505862076, 5523.502884740393, 5556.555475561945, 5608.383077861432, 5039.319691841554, 5084.237364395371, 5092.6180536459915, 5098.821541246113, 5143.022825663112, 4591.678582499259, 4712.269598212282, 4730.787114579852, 4734.479207287196, 4739.0, 5646.774129034875, 5677.77288908439, 5698.202251684685, 5698.2592263005545, 5699.031164701928, 5422.295101636762, 5486.259354987025, 5501.834944951658, 5540.030494663499, 5579.721013949205, 5693.658380497183, 5695.629784064023, 5721.084626459747, 5721.656700597978, 5727.0, 5236.0575096483, 5422.105352616774, 5422.620416570802, 5451.591130665137, 5473.0, 5363.463653634605, 5506.944930550643, 5531.751071201886, 5546.029444847055, 5601.411851755507, 5374.946250537601, 5380.166074258496, 5382.246485492113, 5387.138057910715, 5392.325959255093, 5147.639665223398, 5169.121249387538, 5382.650127741685, 5405.162199859028, 5411.702356370437, 5263.394709608444, 5318.0, 5346.812861549827, 5349.598780091586, 5370.087085195448, 5386.865328366822, 5405.945940540544, 5441.646292990943, 5445.59158063139, 5499.725013749377, 5095.363079615048, 5102.821401251087, 5167.199084141964, 5251.238570407346, 5276.07668657991], "unit": "score", "name": "dojo.html", "value": 5078.960912244194}, {"lowerIsBetter": false, "replicates": [522.8536009917223, 528.5216878724755, 550.9283793106896, 554.2572952243994, 604.8578584032751, 29146.271343216402, 37969.81015094924, 39009.02477438062, 39103.41344879829, 39111.0, 40419.191616167656, 40938.181236375254, 41015.58984410155, 41024.17951640973, 41026.17947641053, 8530.70142545011, 8690.08754080822, 8721.215090641841, 8729.0, 8733.432326898732, 8493.830123397529, 8625.137486251357, 8639.481631102153, 8644.222020018196, 8883.95558022209, 8844.646214151426, 8921.95539022304, 8923.687670931518, 8924.509151996637, 8933.55332233389, 8804.339674524404, 8906.465612063297, 8914.732558023205, 8915.0, 8917.777055573597, 8768.167024132697, 8914.643414263423, 8934.776630584221, 8946.418482798597, 8947.552622368856, 41106.58893411057, 41272.58727412747, 41569.79215103936, 41621.1675766486, 41649.0, 3142.230153612357, 3172.3655268946304, 3212.767544186731, 3240.9351812963846, 3289.9835500822583, 29843.0, 30546.0, 30708.539371909217, 31037.068887933397, 31136.68863311383, 3521.7358698097487, 3587.9282414351565, 3587.9744696080943, 3630.5280313559333, 3735.9439608405896, 205759.0, 208365.0, 209290.0, 209772.0, 210080.0, 54786.45213547893, 55672.721636392365, 61814.69092654508, 62154.68922655358, 62156.0, 66569.66715166393, 66594.0, 67041.32958670448, 67268.6636566814, 67351.0, 15072.472463463946, 15171.165585892883, 15197.088174709332, 15215.467458638894, 15236.695266094615, 11469.598564050219, 11493.310401375944, 11518.94240528792, 11580.88419115815, 12391.442385092692, 19855.702164467544, 20125.09437075335, 20192.192312307638, 20216.292429764886, 20318.88246146476, 7573.659185336673, 7692.538447693157, 7717.807054823562, 7775.066991961001, 7819.491733037335, 882.3117967984982, 922.2437601167113, 932.9346945713735, 1015.0103648942222, 1043.12377602814, 28606.141815745144, 28816.279593010342, 29303.0, 29650.258743531154, 29688.40623187524, 1021.5556233038652, 1031.257494603884, 1068.257560995101, 1098.785736781336, 1169.3159501691437, 15122.09267443957, 15163.393464261526, 15198.0, 15329.968404109355, 15369.0, 323658.0, 326267.79259348067, 326862.0, 327282.0, 327567.0, 51776.22335664968, 52302.47697523052, 52317.0, 52327.73836130795, 52371.47628523742, 1205.6021512900722, 1231.4520038582923, 1236.2520674991501, 1331.010139840944, 1341.610932829488, 26138.73861261363, 28689.0, 29273.414531709674, 29381.85309073441, 29406.852965735034, 40972.38541421822, 41190.38214426726, 41668.374974374805, 42130.73607791771, 43409.0, 212605.0, 300477.0, 305039.0, 305221.0, 306206.0, 31901.521477178325, 32871.34257314888, 33070.50394244136, 33088.0, 33170.83414582912, 43790.0, 44326.11347773091, 44390.55609443993, 44854.3271850916, 45173.77413112913, 36682.72368152327, 36836.447453287685, 37286.44070338893, 37833.62166378411, 38511.6148838508, 36885.63114368822, 37237.069073273386, 37930.0, 38080.238395232496, 38084.238315232986, 36602.81698591597, 36862.44706329353, 37424.812875936535, 37441.81279093587, 37726.245475089796, 32676.673233268313, 34153.0, 34162.48756268708, 34382.31235375329, 34484.82757586196, 25500.617490737284, 25520.872395637904, 25676.358091047874, 25679.229623111336, 26065.869670651526], "unit": "score", "name": "ext.html", "value": 18397.50447458086}, {"lowerIsBetter": false, "replicates": [357.2693841094961, 357.2729495476704, 361.217963109867, 363.42215876755955, 364.7629041123268, 13876.79184812226, 13979.0, 16659.500214993554, 17284.22221000055, 17697.734533981984, 10805.189610779204, 11108.777824443507, 16191.190440477958, 17066.743998839996, 17097.0, 4899.31409602655, 5066.189409694432, 5069.797208111671, 5074.035933172704, 5074.771635276422, 3772.905677358074, 3875.8255878485534, 4958.231474121499, 5386.218998245252, 5592.7762889484575, 5360.437154098822, 5534.778608855641, 5580.0, 5583.302087239095, 5587.8603034924245, 5499.917501237484, 5516.641418307797, 5517.668939863601, 5517.806876759314, 5523.7238138093335, 5258.0535503609335, 5262.210668399733, 5264.842054738364, 5389.191621256804, 5391.838244852622, 13189.208647481182, 13257.337133143305, 15322.540323790305, 21030.684539731916, 21043.158273669036, 1960.980390196094, 1973.3783858084657, 1997.3907958072782, 2378.2746262389965, 2403.315055209257, 9247.907520924839, 10075.143612792921, 10333.22500812442, 10782.73043173919, 13448.865511344859, 1849.1216672080654, 1868.4207895552286, 1872.915718792644, 1912.6461604603194, 1934.8839069655726, 61500.69249653723, 63550.0, 63983.0, 64298.67850660717, 65032.67483662551, 9881.25890558211, 10137.64518241858, 10545.209109316833, 10555.736106597244, 10766.192535559707, 13937.233452160026, 13969.301534923214, 14103.083299585494, 14113.094732211226, 14132.15207087578, 7907.169747176464, 7949.046114466301, 7949.920500794918, 8019.117897031322, 8022.438429310009, 7738.032745906762, 7749.8450030999065, 7771.533707977539, 7880.921190788134, 7889.0, 4238.745675259494, 4566.383538222364, 4568.0, 4580.083983203373, 4601.102784956901, 1796.1647833757365, 1821.653885761701, 1830.7711536057993, 1844.5296449405316, 1845.9538511537319, 895.3285036222833, 897.9730608081768, 906.7551761024487, 954.737447202025, 987.693814917378, 12164.69588260283, 15863.444779432664, 16157.757633635505, 16645.25096370666, 17556.736648950275, 866.5320726807454, 887.7469921072463, 950.847864341702, 965.2519297544459, 989.7871957529165, 9434.433933963846, 9768.023197680175, 9836.803263934824, 10064.496775161213, 10222.977702229717, 506616.0, 530494.0, 549241.0, 549735.0, 553692.0, 73651.63174184095, 74011.25988740043, 74108.62945685237, 76122.23877761263, 77504.0, 1051.942143182117, 1061.6337363609543, 1068.1241382066787, 1068.1988508618535, 1073.7154654016692, 15256.237188140327, 15397.30712117935, 15454.845451545341, 15540.0, 15699.136547489541, 35863.28273434569, 36169.81915090408, 36326.27347453089, 36746.0, 36893.26213475662, 45524.54475455203, 46017.53982460133, 46263.0, 46518.302225465966, 46835.29747053865, 7299.890501642373, 7419.406447484296, 7582.266088589718, 7611.391088712779, 7813.765587032398, 8230.711925082593, 10143.492825358555, 10687.51906164209, 11063.889361106287, 11311.604093856675, 10555.525001374803, 10593.09958653523, 10685.483870967606, 10745.409002504937, 11092.611758588411, 10678.466076695979, 10795.244332896622, 10830.241883068109, 10839.945800270949, 10885.074768644754, 11017.724556886142, 11017.889821101686, 11031.669049928514, 11040.779184416428, 11149.944250278697, 7810.921890781019, 7870.9606451967375, 7895.092064412666, 7906.248906353887, 7924.84150317002, 10439.0, 10678.519466624177, 10683.0, 10874.293170943864, 10984.0], "unit": "score", "name": "jquery.html", "value": 8333.119781500682}, {"lowerIsBetter": false, "replicates": [1321.3987635625792, 1445.9421623135074, 1446.8119144511209, 1587.4047232287892, 1768.699321115411, 6716.294789047147, 7315.158756742976, 7480.551166929974, 7487.176410594844, 7488.850222995537, 7233.927660723391, 7420.146683131442, 7421.851562968737, 7423.888641670365, 7431.851362972738, 1894.9905250473728, 1918.7409699690572, 2101.590189912964, 2127.7340332458443, 2190.145843121184, 2281.7946384825364, 2288.96566551501, 2289.3360925331717, 2291.541691661666, 2295.0704964489323, 2182.6180418426793, 2255.23322070496, 2256.029907139929, 2258.2660635293514, 2261.536385041071, 2183.246779860953, 2194.122351059581, 2206.172685243034, 2218.966715499269, 2221.544583360407, 2165.7184566006317, 2170.522485053286, 2196.7034450349156, 2197.4286685461734, 2198.6482162854027, 7653.846923061507, 7727.574983375912, 7731.072271327421, 7732.961335193344, 7735.419843511759, 4548.295014272793, 4624.190766615829, 4646.326282689025, 4651.348811166439, 4663.067386522709, 2819.1401622505127, 2874.9137525874257, 2915.1546051644996, 2928.1508362574828, 2942.8528573571234, 944.9055094490565, 948.4262021476976, 951.0251991708485, 953.0069010844609, 989.9950500247525, 10320.174386049099, 10322.638707645272, 10348.068673819393, 10349.948250258776, 10371.79256414875, 4096.242195193899, 4109.753414795062, 4159.147374788161, 4172.332426811696, 4175.91648167035, 8926.0, 8945.910540894507, 8946.060663630225, 8950.060243674321, 9014.729558113268, 4655.534446555385, 4658.34783130362, 4679.485256621769, 4685.226937555333, 4693.647976401783, 4275.444192254987, 4276.828926842892, 4278.89302767427, 4284.528701842794, 4286.507051689034, 3297.7032067113596, 3556.5020897074432, 3571.053670777246, 3578.3916734155255, 3588.6052534221217, 1156.2888823373564, 1213.3023511480933, 1215.155466950461, 1215.7811593913004, 1220.5483970930813, 1301.2452777389092, 1303.1920209470188, 1315.0991570774052, 1315.4540865540694, 1325.648703093681, 7038.753643622448, 7064.540804847668, 7146.178189508169, 7147.070880785464, 7148.177959534616, 1111.4553868604326, 1117.2962226640159, 1121.9439028048564, 1127.3968426891574, 1134.0077432246785, 5749.9712501437225, 5849.2103566018895, 5849.736761845727, 5851.473367396955, 5855.0, 8944.642214311485, 8978.640854365884, 9107.043760405195, 9214.0, 9262.073792620818, 8995.505247211466, 9147.0852914708, 9151.130642588943, 9170.220531254785, 9170.266378689688, 7043.119610048744, 7131.286871312931, 7237.927620723831, 7248.238934911864, 7259.346658800628, 6861.176658800776, 6970.407515361048, 6985.336393042653, 6991.965040174767, 7005.964970175117, 7989.440739148204, 8310.83378332442, 8425.95787021061, 8433.915660843559, 8464.66141354339, 7911.367090632851, 7934.20657934202, 7965.084015338311, 8036.116027237116, 8044.115147333671, 6473.805785826245, 6561.671916404256, 6666.26671066192, 6677.532572720057, 6682.431993280626, 6388.776392826415, 6990.2660220678135, 7183.102112235971, 7206.351428371472, 7214.603196824225, 6800.863982720417, 6931.306869313028, 7016.894746578703, 7029.156501219886, 7115.53749006313, 6931.306869313028, 6942.375186233263, 6958.921367188094, 6967.09427774386, 7003.789886303419, 6988.37104660583, 7036.824079398056, 7053.682584283617, 7060.0, 7066.681999310146, 6057.939860524479, 6127.417895299939, 6156.815295541141, 6166.753329866755, 6192.876142477216, 6259.061140828912, 6278.15244941927, 6294.8111556653375, 6296.622202667671, 6305.96847015762], "unit": "score", "name": "mootools.html", "value": 4392.544689467239}, {"lowerIsBetter": false, "replicates": [325.9185203699075, 330.5867665418227, 333.79972016789924, 338.90171850163455, 343.18835952971233, 5750.971245143768, 5870.765169393225, 5893.646381217125, 5950.10748387742, 5973.223480947481, 5731.083026715726, 5800.65196088235, 5800.9129863051985, 5818.389069147742, 5825.330087039981, 4580.9541904580865, 4586.357909892609, 4588.197065513538, 4595.701279416844, 4596.448426188862, 4363.410939523172, 4472.977635111836, 4479.977600112011, 4487.5063742988405, 4586.724796512203, 4436.600705936465, 4494.460664720238, 4511.3233015047845, 4519.79660915258, 4524.592786649201, 4522.932156017662, 4536.478304994918, 4537.9773101134615, 4545.136424079415, 4548.044910568785, 4010.5187377514885, 4011.498562679665, 4023.4970628671417, 4031.1333063391216, 4031.2743706132883, 5460.590455715837, 5631.746571404296, 5638.577106716972, 5655.4061823508355, 5668.121441176583, 5294.629375943686, 5305.522502974751, 5306.230596563515, 5308.389535203462, 5313.229581710631, 5966.075258334965, 6296.338884417116, 6300.369963003709, 6301.180846489973, 6301.87396252077, 4345.500267469219, 4422.336649502568, 4445.177642136183, 4451.532589078132, 4466.1067786442845, 6414.294427612959, 6505.512086593477, 6522.608643481359, 6523.641199734013, 6524.151860258136, 4532.9320060199125, 4538.160440318552, 4539.114872599877, 4545.409096817459, 4549.385832912581, 4513.864584062418, 4602.838900638461, 4617.884552886205, 4618.907621847544, 4624.884377890579, 5255.159174532133, 5265.578753699695, 5267.367915850046, 5269.446708095671, 5271.235670827708, 6253.437190652863, 6274.152989346379, 6282.277538083087, 6289.0, 6297.748090076438, 1599.4082189589926, 1621.578389618684, 1624.8781341399442, 1627.9267432965546, 1630.5515983104503, 1094.8412480190327, 1100.4112799652148, 1101.9779604408027, 1112.9276597021167, 1127.5997021057572, 5919.3192782829665, 5921.970390148108, 5925.051991681396, 5928.584999050025, 5930.55520835939, 6429.6142231466265, 6442.806715798533, 6445.355464453517, 6446.4520515756685, 6448.548601597843, 5828.154917536934, 5872.530197584183, 5921.911171332434, 5927.614705044159, 5929.169916211734, 3400.846961886721, 3464.082018265162, 3465.358908601917, 3478.9304213916084, 3482.9825850870584, 6676.365745254193, 6704.899426508607, 6716.1604799400075, 6720.798376048726, 6734.797956061326, 6549.476041916635, 6568.868622627616, 6578.27638959714, 6585.934140658628, 6591.505637077238, 6515.413612774873, 6688.0, 6714.060031595581, 6717.429018533382, 6720.495962802712, 6234.942468985133, 6348.650824204713, 6425.518086143465, 6433.260175079926, 6435.03474478832, 6289.088082228142, 6381.776637817654, 6397.744090236339, 6430.324815894263, 6433.839154021187, 6670.199576050905, 6690.029945657755, 6708.127943367526, 6708.8993665094085, 6714.83212919681, 4266.850660226877, 4549.5905368517, 4553.521880202531, 4555.430571178603, 4556.2254416748565, 6476.805695829133, 6478.805635830932, 6488.12410324619, 6498.415142637185, 6503.382178693017, 6285.182926219562, 6288.5598008138995, 6292.779752708633, 6294.842628934313, 6299.118123462627, 6181.474574661204, 6232.875342493216, 6281.340459251713, 6282.089097080989, 6289.937100628935, 6182.28903676083, 6186.597871138361, 6189.6286222826775, 6194.535409844189, 6200.3179650237535, 6303.936960630335, 6321.304656487875, 6335.239771227482, 6337.04944258365, 6341.334159913143, 6070.726817293144, 6177.938220617736, 6182.227221597301, 6182.227221597301, 6183.041628547582], "unit": "score", "name": "prototype.html", "value": 4744.936260933179}, {"lowerIsBetter": false, "replicates": [750.9849803003937, 760.4182800157879, 800.5270302643139, 820.5199958024556, 829.1294141151793, 13481.123726957741, 13775.862241377596, 13786.448542058331, 13788.0, 13803.861961380384, 13058.673533161676, 13110.475580976774, 13129.540466083665, 13133.802992955114, 13150.408231629575, 673.4141297071554, 816.3958670583755, 820.3724151024442, 840.970566030189, 841.8021764885247, 833.3957880536593, 837.5895811052571, 837.7905523619095, 839.8320335932807, 840.487302745328, 710.3535782437982, 878.7495563764328, 879.9428037177563, 880.0143838900441, 880.5685214245005, 704.781517729503, 705.206642527157, 705.8023753349071, 845.3237410071918, 861.6165806216236, 633.0188208277152, 633.4299130782287, 633.7813454358239, 634.0774173577433, 634.815903388017, 13289.269090200036, 13298.468061277537, 13415.932920335434, 13428.664283392896, 13443.193408395528, 12808.359582020956, 13058.804117938238, 13182.868171318356, 13219.471221151143, 13333.466661333536, 10543.31468454548, 10715.678529644045, 10748.516316765765, 10879.0, 10898.891011089867, 3621.746477746559, 3649.069487280753, 3670.743047986642, 3672.632736726306, 3777.263433630443, 48735.75632121852, 48817.51182488165, 48891.511084889054, 49018.0, 49132.75433622845, 10399.0, 10431.68704938853, 10482.47587620616, 10630.787384252271, 11024.393658348707, 18875.0, 18905.243790248234, 18910.149043293084, 18928.43214703561, 18938.14778334978, 7427.740029099064, 7637.274458926504, 7653.923460765321, 7743.690252389954, 7784.649690763929, 4240.766757828349, 4253.914921701548, 4328.7402755834755, 4445.177642136216, 4586.72479651222, 3053.8931137410527, 3072.7080927311868, 3083.152133163353, 3098.98450507746, 3100.98449507751, 561.6068751873705, 565.104309669179, 565.3159676791129, 568.6843801690019, 588.65563645268, 566.6175331651119, 694.0907411291224, 699.2729937996506, 701.8561194955022, 709.2481969112757, 9269.16577508014, 9534.856977145348, 9568.146096849066, 9638.228941684649, 9759.756006099762, 549.5630973376176, 580.7996241296746, 619.6096459230656, 709.2694524639629, 738.9298016688406, 4220.683448741357, 4247.936280955788, 4333.15503476819, 4460.8661740147845, 4467.73193608378, 56762.0, 56929.0, 57214.0, 58291.0, 58713.0, 50996.0, 52350.21474677883, 52726.209106863425, 52778.20832687513, 52848.20727689088, 46009.30986035212, 46090.769546152056, 46444.535554644695, 46919.5308046922, 47340.0, 8841.292696584387, 8873.600687969187, 8888.644454222018, 8889.866652000355, 8945.664728422878, 34106.48840267448, 34143.14642133967, 34588.82705586456, 34613.0, 34897.47653785144, 41428.58571414247, 41803.37294940639, 44996.0, 46321.76839115783, 46426.76786616045, 10401.479926003518, 10466.110380617429, 10723.624673136403, 10803.621873234399, 10888.346699198073, 10156.644517441853, 10436.165106791286, 10772.676819695422, 11789.882101179222, 11847.229930054518, 10635.14918806478, 10921.0, 11020.228583999364, 11499.597514086967, 11905.345206013752, 10574.312669676447, 10591.576336946437, 10897.291676041032, 11151.275167114112, 11605.6518304451, 9755.9024409755, 9760.755981100529, 9865.852012219679, 9896.10935015852, 11177.944110279397, 9446.433214006907, 9530.237580993642, 9668.56491457872, 9849.0, 9853.408795472295, 9181.0, 9246.398984066014, 9647.1317581418, 9975.750606234902, 10308.866823012944], "unit": "score", "name": "yui.html", "value": 6335.057454357404}], "name": "dromaeo_css", "value": 6844.572609161704}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 106.0, 112.0, 112.0, 111.0, 102.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [150.0, 136.0, 154.0, 192.0, 127.0, 149.0, 157.0, 131.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 162.0, 159.0, 162.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 104.0, 94.0, 74.0, 73.0, 74.0, 110.0, 97.0, 84.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 140.0, 94.0, 95.0, 97.0, 140.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 57.0, 56.0, 56.0, 58.0, 65.0, 55.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 70.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 85.0, 89.0, 82.0, 81.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 114.0, 115.0, 115.0, 120.0, 126.0, 114.0, 114.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [142.0, 155.0, 153.0, 153.0, 161.0, 142.0, 152.0, 151.0, 151.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 67.0, 69.0, 67.0, 66.0, 71.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1518.1999999999998}]} 05:30:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1518.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6844.57"}}} 05:30:59 INFO - Return code: 0 05:30:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:30:59 INFO - # TBPL SUCCESS # 05:30:59 INFO - Running post-action listener: _resource_record_post_action 05:30:59 INFO - Running post-run listener: _resource_record_post_run 05:31:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555155456; Read time: 220; Write time: 748268 05:31:00 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 240721920; Read time: 0; Write time: 441948 05:31:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298926080; Read time: 220; Write time: 302260 05:31:00 INFO - Running post-run listener: _upload_blobber_files 05:31:00 INFO - Blob upload gear active. 05:31:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:31:00 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 05:31:00 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'] 05:31:00 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 05:31:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:01 INFO - (blobuploader) - INFO - Done attempting. 05:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:03 INFO - (blobuploader) - INFO - Done attempting. 05:31:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:03 INFO - Return code: 0 05:31:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:31:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/38bd8fc7eb772dbd70efc0da177d4c2fe63bbf627e41d2e0a4cc7d17991e83b064a09dead77691d01d091f53f7970e6f67440b40b6c674d4c832ff381eda3da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d63d716f50ec4bf169bbfbeebf249060be34143e640553747c415d998ef71f92e7c0fa23a660336fa6de0273a0b43c328b3b8491922203edec31d2fed8469db"} 05:31:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:31:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:31:03 INFO - Contents: 05:31:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/38bd8fc7eb772dbd70efc0da177d4c2fe63bbf627e41d2e0a4cc7d17991e83b064a09dead77691d01d091f53f7970e6f67440b40b6c674d4c832ff381eda3da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d63d716f50ec4bf169bbfbeebf249060be34143e640553747c415d998ef71f92e7c0fa23a660336fa6de0273a0b43c328b3b8491922203edec31d2fed8469db"} 05:31:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:03 INFO - Copying logs to upload dir... 05:31:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:31:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.870016 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-18 05:31:02.951646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:31:02.954937) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 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/38bd8fc7eb772dbd70efc0da177d4c2fe63bbf627e41d2e0a4cc7d17991e83b064a09dead77691d01d091f53f7970e6f67440b40b6c674d4c832ff381eda3da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d63d716f50ec4bf169bbfbeebf249060be34143e640553747c415d998ef71f92e7c0fa23a660336fa6de0273a0b43c328b3b8491922203edec31d2fed8469db"} build_url:https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/P6yBJKQ3S6y8f2mfkMH95w/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/38bd8fc7eb772dbd70efc0da177d4c2fe63bbf627e41d2e0a4cc7d17991e83b064a09dead77691d01d091f53f7970e6f67440b40b6c674d4c832ff381eda3da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8d63d716f50ec4bf169bbfbeebf249060be34143e640553747c415d998ef71f92e7c0fa23a660336fa6de0273a0b43c328b3b8491922203edec31d2fed8469db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:31:02.979726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:31:02.980152) ========= 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=62c568580acbfdaac3eec7be000001dc-1455798636.708859-622623194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:31:03.062603) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:31:03.062942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:31:03.063248) ========= ========= Total master_lag: 0.27 =========