builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1452689784.62 results: success (0) buildid: 20160113023001 builduid: c8fec7edb1c34a97b6276890db19a89d revision: ac6d95e5a908a875b8bd87ca348832e443c9351f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.618043) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.618434) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.618730) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006347 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.643999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.644285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.658574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.658864) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.707724) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.707985) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.708355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.708635) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:56:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-01-13 04:56:25 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.901740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.902028) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016642 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:24.950512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:56:24.950822) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ac6d95e5a908a875b8bd87ca348832e443c9351f --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 ac6d95e5a908a875b8bd87ca348832e443c9351f --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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:56:25,769 truncating revision to first 12 chars 2016-01-13 04:56:25,770 Setting DEBUG logging. 2016-01-13 04:56:25,770 attempt 1/10 2016-01-13 04:56:25,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ac6d95e5a908?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:56:26,663 unpacking tar archive at: b2g-inbound-ac6d95e5a908/testing/mozharness/ program finished with exit code 0 elapsedTime=1.175466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:56:26.139148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:26.139453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:26.149620) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:26.149928) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:56:26.150433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-01-13 04:56:26.150768) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:27 INFO - MultiFileLogger online at 20160113 04:56:27 in /builds/slave/test-pgo 04:56:27 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 04:56:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:56:27 INFO - {'append_to_log': False, 04:56:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:56:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:56:27 INFO - 'branch': 'B2G-Inbound', 04:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:27 INFO - 'config_files': ('talos/linux_config.py',), 04:56:27 INFO - 'default_actions': ('clobber', 04:56:27 INFO - 'read-buildbot-config', 04:56:27 INFO - 'download-and-extract', 04:56:27 INFO - 'populate-webroot', 04:56:27 INFO - 'create-virtualenv', 04:56:27 INFO - 'install', 04:56:27 INFO - 'run-tests'), 04:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:27 INFO - 'download_minidump_stackwalk': True, 04:56:27 INFO - 'download_symbols': 'ondemand', 04:56:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:27 INFO - 'installer_path': 'installer.exe', 04:56:27 INFO - 'log_level': 'info', 04:56:27 INFO - 'log_name': 'talos', 04:56:27 INFO - 'log_to_console': True, 04:56:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:27 INFO - 'opt_config_files': (), 04:56:27 INFO - 'pip_index': False, 04:56:27 INFO - 'sps_profile': False, 04:56:27 INFO - 'sps_profile_interval': 0, 04:56:27 INFO - 'suite': 'dromaeojs', 04:56:27 INFO - 'system_bits': '32', 04:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:27 INFO - 'title': 'talos-linux64-ix-042', 04:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:27 INFO - 'use_talos_json': True, 04:56:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:27 INFO - 'work_dir': 'build'} 04:56:27 INFO - ##### 04:56:27 INFO - ##### Running clobber step. 04:56:27 INFO - ##### 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: clobber 04:56:27 INFO - rmtree: /builds/slave/test-pgo/build 04:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:56:27 INFO - Running post-action listener: _resource_record_post_action 04:56:27 INFO - ##### 04:56:27 INFO - ##### Running read-buildbot-config step. 04:56:27 INFO - ##### 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: read_buildbot_config 04:56:27 INFO - Using buildbot properties: 04:56:27 INFO - { 04:56:27 INFO - "project": "", 04:56:27 INFO - "product": "firefox", 04:56:27 INFO - "script_repo_revision": "production", 04:56:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:56:27 INFO - "repository": "", 04:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:56:27 INFO - "buildid": "20160113023001", 04:56:27 INFO - "pgo_build": "True", 04:56:27 INFO - "basedir": "/builds/slave/test-pgo", 04:56:27 INFO - "buildnumber": 1106, 04:56:27 INFO - "slavename": "talos-linux64-ix-042", 04:56:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:56:27 INFO - "platform": "ubuntu64_hw", 04:56:27 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:56:27 INFO - "branch": "b2g-inbound", 04:56:27 INFO - "repo_path": "integration/b2g-inbound", 04:56:27 INFO - "revision": "ac6d95e5a908a875b8bd87ca348832e443c9351f", 04:56:27 INFO - "stage_platform": "linux64-pgo", 04:56:27 INFO - "builduid": "c8fec7edb1c34a97b6276890db19a89d", 04:56:27 INFO - "slavebuilddir": "test" 04:56:27 INFO - } 04:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:56:27 INFO - Running post-action listener: _resource_record_post_action 04:56:27 INFO - ##### 04:56:27 INFO - ##### Running download-and-extract step. 04:56:27 INFO - ##### 04:56:27 INFO - Running pre-action listener: _resource_record_pre_action 04:56:27 INFO - Running main action method: download_and_extract 04:56:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:56:27 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')]} 04:56:27 INFO - https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/test_packages.json 04:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/test_packages.json 04:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:56:29 INFO - Downloaded 1302 bytes. 04:56:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:56:29 INFO - Using the following test package requirements: 04:56:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:56:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'jsshell-linux-x86_64.zip'], 04:56:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:56:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:56:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:56:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:56:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:56:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:56:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:56:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:29 INFO - https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:56:55 INFO - Downloaded 24026563 bytes. 04:56:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:56:56 INFO - Return code: 0 04:56:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:56 INFO - https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:56:59 INFO - Downloaded 24026563 bytes. 04:56:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:56:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:56:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:57:00 INFO - Return code: 0 04:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:00 INFO - https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:57:08 INFO - Downloaded 11132285 bytes. 04:57:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:57:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:57:08 INFO - Return code: 0 04:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:08 INFO - https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:57:12 INFO - Downloaded 55746464 bytes. 04:57:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:12 INFO - mkdir: /builds/slave/test-pgo/properties 04:57:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:57:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:57:12 INFO - Contents: 04:57:12 INFO - build_url:https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:12 INFO - Running post-action listener: _resource_record_post_action 04:57:12 INFO - Running post-action listener: set_extra_try_arguments 04:57:12 INFO - ##### 04:57:12 INFO - ##### Running populate-webroot step. 04:57:12 INFO - ##### 04:57:12 INFO - Running pre-action listener: _resource_record_pre_action 04:57:12 INFO - Running main action method: populate_webroot 04:57:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:12 INFO - '--tppagecycles', 04:57:12 INFO - '7'], 04:57:12 INFO - 'tests': ['tsvgm']}}, 04:57:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'tests': ['damp', 'tps']}, 04:57:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['damp', 'tps']}, 04:57:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:12 INFO - 'other': {'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'other_l64': {'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:12 INFO - 'ts_paint', 04:57:12 INFO - 'tpaint', 04:57:12 INFO - 'sessionrestore', 04:57:12 INFO - 'sessionrestore_no_auto_restore']}, 04:57:12 INFO - 'svgr': {'tests': ['tsvgx', 04:57:12 INFO - 'tsvgr_opacity', 04:57:12 INFO - 'tart', 04:57:12 INFO - 'tscrollx', 04:57:12 INFO - 'cart']}, 04:57:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['tsvgx', 04:57:12 INFO - 'tsvgr_opacity', 04:57:12 INFO - 'tart', 04:57:12 INFO - 'tscrollx', 04:57:12 INFO - 'cart']}, 04:57:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'tests': ['tp5o']}, 04:57:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'talos_options': ['--e10s'], 04:57:12 INFO - 'tests': ['tp5o']}, 04:57:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'talos_options': ['--xperf_path', 04:57:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:12 INFO - 'tests': ['tp5n']}, 04:57:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:12 INFO - 'talos_options': ['--e10s', 04:57:12 INFO - '--xperf_path', 04:57:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:12 INFO - 'tests': ['tp5n']}}, 04:57:12 INFO - 'talos.zip': {'path': '', 04:57:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:12 INFO - Running post-action listener: _resource_record_post_action 04:57:12 INFO - ##### 04:57:12 INFO - ##### Running create-virtualenv step. 04:57:12 INFO - ##### 04:57:12 INFO - Running pre-action listener: _resource_record_pre_action 04:57:12 INFO - Running main action method: create_virtualenv 04:57:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:57:12 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 04:57:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:13 INFO - Using real prefix '/usr' 04:57:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:57:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:15 INFO - Installing pip.................done. 04:57:15 INFO - Return code: 0 04:57:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:15 INFO - Using env: {'DISPLAY': ':0', 04:57:15 INFO - 'HOME': '/home/cltbld', 04:57:15 INFO - 'LANG': 'en_US.UTF-8', 04:57:15 INFO - 'LANGUAGE': 'en_US:en', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MAIL': '/var/mail/cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SHLVL': '1', 04:57:15 INFO - 'TERM': 'linux', 04:57:15 INFO - 'TMOUT': '86400', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - '_': '/tools/buildbot/bin/python'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 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 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:15 INFO - Using env: {'DISPLAY': ':0', 04:57:15 INFO - 'HOME': '/home/cltbld', 04:57:15 INFO - 'LANG': 'en_US.UTF-8', 04:57:15 INFO - 'LANGUAGE': 'en_US:en', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MAIL': '/var/mail/cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SHLVL': '1', 04:57:15 INFO - 'TERM': 'linux', 04:57:15 INFO - 'TMOUT': '86400', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - '_': '/tools/buildbot/bin/python'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 INFO - Downloading/unpacking psutil>=0.7.1 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:15 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 04:57:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:57:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:57:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:17 INFO - Installing collected packages: psutil 04:57:17 INFO - Running setup.py install for psutil 04:57:17 INFO - building 'psutil._psutil_linux' extension 04:57:17 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 04:57:18 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 04:57:18 INFO - building 'psutil._psutil_posix' extension 04:57:18 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 04:57:18 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 04:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:18 INFO - Successfully installed psutil 04:57:18 INFO - Cleaning up... 04:57:18 INFO - Return code: 0 04:57:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:18 INFO - Using env: {'DISPLAY': ':0', 04:57:18 INFO - 'HOME': '/home/cltbld', 04:57:18 INFO - 'LANG': 'en_US.UTF-8', 04:57:18 INFO - 'LANGUAGE': 'en_US:en', 04:57:18 INFO - 'LOGNAME': 'cltbld', 04:57:18 INFO - 'MAIL': '/var/mail/cltbld', 04:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:18 INFO - 'MOZ_NO_REMOTE': '1', 04:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:18 INFO - 'NO_EM_RESTART': '1', 04:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:18 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:18 INFO - 'SHELL': '/bin/bash', 04:57:18 INFO - 'SHLVL': '1', 04:57:18 INFO - 'TERM': 'linux', 04:57:18 INFO - 'TMOUT': '86400', 04:57:18 INFO - 'USER': 'cltbld', 04:57:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:18 INFO - '_': '/tools/buildbot/bin/python'} 04:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:57:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:57:20 INFO - Installing collected packages: mozsystemmonitor 04:57:20 INFO - Running setup.py install for mozsystemmonitor 04:57:20 INFO - Successfully installed mozsystemmonitor 04:57:20 INFO - Cleaning up... 04:57:20 INFO - Return code: 0 04:57:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:57:20 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')]} 04:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:20 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')]} 04:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:20 INFO - Using env: {'DISPLAY': ':0', 04:57:20 INFO - 'HOME': '/home/cltbld', 04:57:20 INFO - 'LANG': 'en_US.UTF-8', 04:57:20 INFO - 'LANGUAGE': 'en_US:en', 04:57:20 INFO - 'LOGNAME': 'cltbld', 04:57:20 INFO - 'MAIL': '/var/mail/cltbld', 04:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:20 INFO - 'MOZ_NO_REMOTE': '1', 04:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:20 INFO - 'NO_EM_RESTART': '1', 04:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:20 INFO - 'SHELL': '/bin/bash', 04:57:20 INFO - 'SHLVL': '1', 04:57:20 INFO - 'TERM': 'linux', 04:57:20 INFO - 'TMOUT': '86400', 04:57:20 INFO - 'USER': 'cltbld', 04:57:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:20 INFO - '_': '/tools/buildbot/bin/python'} 04:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:57:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:57:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:57:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:23 INFO - Downloading docopt-0.6.1.tar.gz 04:57:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:57:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:23 INFO - Running setup.py install for blobuploader 04:57:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:57:23 INFO - Running setup.py install for requests 04:57:23 INFO - Running setup.py install for docopt 04:57:23 INFO - Successfully installed blobuploader requests docopt 04:57:23 INFO - Cleaning up... 04:57:23 INFO - Return code: 0 04:57:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:23 INFO - Using env: {'DISPLAY': ':0', 04:57:23 INFO - 'HOME': '/home/cltbld', 04:57:23 INFO - 'LANG': 'en_US.UTF-8', 04:57:23 INFO - 'LANGUAGE': 'en_US:en', 04:57:23 INFO - 'LOGNAME': 'cltbld', 04:57:23 INFO - 'MAIL': '/var/mail/cltbld', 04:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:23 INFO - 'MOZ_NO_REMOTE': '1', 04:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:23 INFO - 'NO_EM_RESTART': '1', 04:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:23 INFO - 'SHELL': '/bin/bash', 04:57:23 INFO - 'SHLVL': '1', 04:57:23 INFO - 'TERM': 'linux', 04:57:23 INFO - 'TMOUT': '86400', 04:57:23 INFO - 'USER': 'cltbld', 04:57:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:23 INFO - '_': '/tools/buildbot/bin/python'} 04:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:23 INFO - Running setup.py (path:/tmp/pip-C3hF5x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:23 INFO - Running setup.py (path:/tmp/pip-a5s7pd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:24 INFO - Running setup.py (path:/tmp/pip-iHEB0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:24 INFO - Running setup.py (path:/tmp/pip-cMeW0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:24 INFO - Running setup.py (path:/tmp/pip-a6SkVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:24 INFO - Running setup.py (path:/tmp/pip-ILoMEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:24 INFO - Running setup.py (path:/tmp/pip-fqbqaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:24 INFO - Running setup.py (path:/tmp/pip-m_vGDm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:24 INFO - Running setup.py (path:/tmp/pip-e6dOhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:24 INFO - Running setup.py (path:/tmp/pip-UL7SMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:24 INFO - Running setup.py (path:/tmp/pip-o47M77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:24 INFO - Running setup.py (path:/tmp/pip-z9pbSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:24 INFO - Running setup.py (path:/tmp/pip-vuBSPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:24 INFO - Running setup.py (path:/tmp/pip-FphJmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:24 INFO - Running setup.py (path:/tmp/pip-LszCHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:24 INFO - Running setup.py (path:/tmp/pip-N6hadb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:25 INFO - Running setup.py (path:/tmp/pip-zHvGPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:25 INFO - Running setup.py install for manifestparser 04:57:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Running setup.py install for mozcrash 04:57:25 INFO - Running setup.py install for mozdebug 04:57:25 INFO - Running setup.py install for mozdevice 04:57:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Running setup.py install for mozfile 04:57:25 INFO - Running setup.py install for mozhttpd 04:57:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Running setup.py install for mozinfo 04:57:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Running setup.py install for mozInstall 04:57:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:57:25 INFO - Running setup.py install for mozleak 04:57:26 INFO - Running setup.py install for mozlog 04:57:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Running setup.py install for moznetwork 04:57:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Running setup.py install for mozprocess 04:57:26 INFO - Running setup.py install for mozprofile 04:57:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Running setup.py install for mozrunner 04:57:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Running setup.py install for mozscreenshot 04:57:26 INFO - Running setup.py install for moztest 04:57:26 INFO - Running setup.py install for mozversion 04:57:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:26 INFO - Cleaning up... 04:57:26 INFO - Return code: 0 04:57:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:26 INFO - Using env: {'DISPLAY': ':0', 04:57:26 INFO - 'HOME': '/home/cltbld', 04:57:26 INFO - 'LANG': 'en_US.UTF-8', 04:57:26 INFO - 'LANGUAGE': 'en_US:en', 04:57:26 INFO - 'LOGNAME': 'cltbld', 04:57:26 INFO - 'MAIL': '/var/mail/cltbld', 04:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:26 INFO - 'MOZ_NO_REMOTE': '1', 04:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:26 INFO - 'NO_EM_RESTART': '1', 04:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:26 INFO - 'SHELL': '/bin/bash', 04:57:26 INFO - 'SHLVL': '1', 04:57:26 INFO - 'TERM': 'linux', 04:57:26 INFO - 'TMOUT': '86400', 04:57:26 INFO - 'USER': 'cltbld', 04:57:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:26 INFO - '_': '/tools/buildbot/bin/python'} 04:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:27 INFO - Running setup.py (path:/tmp/pip-f6j5m5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:27 INFO - Running setup.py (path:/tmp/pip-oJSqfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:27 INFO - Running setup.py (path:/tmp/pip-X3ZbvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:27 INFO - Running setup.py (path:/tmp/pip-8WDICq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:27 INFO - Running setup.py (path:/tmp/pip-nnYsLw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:27 INFO - Running setup.py (path:/tmp/pip-QmBOSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:27 INFO - Running setup.py (path:/tmp/pip-B4IaQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:27 INFO - Running setup.py (path:/tmp/pip-iaNKld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:27 INFO - Running setup.py (path:/tmp/pip-1n13Qw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:27 INFO - Running setup.py (path:/tmp/pip-Lhquiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:27 INFO - Running setup.py (path:/tmp/pip-JlGBuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:27 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)) 04:57:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:27 INFO - Running setup.py (path:/tmp/pip-fd2VeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:28 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)) 04:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:28 INFO - Running setup.py (path:/tmp/pip-M8WXlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:28 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)) 04:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:28 INFO - Running setup.py (path:/tmp/pip-hIhJ70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:28 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)) 04:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:28 INFO - Running setup.py (path:/tmp/pip-Xbvkpl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:28 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)) 04:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:28 INFO - Running setup.py (path:/tmp/pip-29ohBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:28 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)) 04:57:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:28 INFO - Running setup.py (path:/tmp/pip-KM3AeA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:28 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)) 04:57:28 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)) 04:57:28 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)) 04:57:28 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)) 04:57:28 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:28 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:28 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 04:57:30 INFO - Downloading blessings-1.5.1.tar.gz 04:57:30 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:57:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:30 INFO - Installing collected packages: blessings 04:57:30 INFO - Running setup.py install for blessings 04:57:30 INFO - Successfully installed blessings 04:57:30 INFO - Cleaning up... 04:57:30 INFO - Return code: 0 04:57:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:57:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:57:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:57:30 INFO - Reading from file tmpfile_stdout 04:57:30 INFO - Current package versions: 04:57:30 INFO - argparse == 1.2.1 04:57:30 INFO - blessings == 1.5.1 04:57:30 INFO - blobuploader == 1.2.4 04:57:30 INFO - docopt == 0.6.1 04:57:30 INFO - manifestparser == 1.1 04:57:30 INFO - mozInstall == 1.12 04:57:30 INFO - mozcrash == 0.16 04:57:30 INFO - mozdebug == 0.1 04:57:30 INFO - mozdevice == 0.47 04:57:30 INFO - mozfile == 1.2 04:57:30 INFO - mozhttpd == 0.7 04:57:30 INFO - mozinfo == 0.9 04:57:30 INFO - mozleak == 0.1 04:57:30 INFO - mozlog == 3.1 04:57:30 INFO - moznetwork == 0.27 04:57:30 INFO - mozprocess == 0.22 04:57:30 INFO - mozprofile == 0.28 04:57:30 INFO - mozrunner == 6.11 04:57:30 INFO - mozscreenshot == 0.1 04:57:30 INFO - mozsystemmonitor == 0.0 04:57:30 INFO - moztest == 0.7 04:57:30 INFO - mozversion == 1.4 04:57:30 INFO - psutil == 3.1.1 04:57:30 INFO - requests == 1.2.3 04:57:30 INFO - wsgiref == 0.1.2 04:57:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:30 INFO - Using env: {'DISPLAY': ':0', 04:57:30 INFO - 'HOME': '/home/cltbld', 04:57:30 INFO - 'LANG': 'en_US.UTF-8', 04:57:30 INFO - 'LANGUAGE': 'en_US:en', 04:57:30 INFO - 'LOGNAME': 'cltbld', 04:57:30 INFO - 'MAIL': '/var/mail/cltbld', 04:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:30 INFO - 'MOZ_NO_REMOTE': '1', 04:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:30 INFO - 'NO_EM_RESTART': '1', 04:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:30 INFO - 'SHELL': '/bin/bash', 04:57:30 INFO - 'SHLVL': '1', 04:57:30 INFO - 'TERM': 'linux', 04:57:30 INFO - 'TMOUT': '86400', 04:57:30 INFO - 'USER': 'cltbld', 04:57:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:30 INFO - '_': '/tools/buildbot/bin/python'} 04:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 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)) 04:57:30 INFO - Cleaning up... 04:57:30 INFO - Return code: 0 04:57:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:30 INFO - Using env: {'DISPLAY': ':0', 04:57:30 INFO - 'HOME': '/home/cltbld', 04:57:30 INFO - 'LANG': 'en_US.UTF-8', 04:57:30 INFO - 'LANGUAGE': 'en_US:en', 04:57:30 INFO - 'LOGNAME': 'cltbld', 04:57:30 INFO - 'MAIL': '/var/mail/cltbld', 04:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:30 INFO - 'MOZ_NO_REMOTE': '1', 04:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:30 INFO - 'NO_EM_RESTART': '1', 04:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:30 INFO - 'SHELL': '/bin/bash', 04:57:30 INFO - 'SHLVL': '1', 04:57:30 INFO - 'TERM': 'linux', 04:57:30 INFO - 'TMOUT': '86400', 04:57:30 INFO - 'USER': 'cltbld', 04:57:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:30 INFO - '_': '/tools/buildbot/bin/python'} 04:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:30 INFO - Downloading/unpacking jsonschema 04:57:30 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 04:57:30 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 04:57:30 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 04:57:30 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 04:57:30 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 04:57:30 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 04:57:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:57:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:57:32 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 04:57:32 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 04:57:32 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 04:57:32 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 04:57:32 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 04:57:32 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 04:57:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:57:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:32 INFO - warning: no files found matching '*.txt' 04:57:32 INFO - no previously-included directories found matching 'build' 04:57:32 INFO - no previously-included directories found matching 'dist' 04:57:32 INFO - no previously-included directories found matching '.git*' 04:57:33 INFO - Installing collected packages: jsonschema, functools32 04:57:33 INFO - Running setup.py install for functools32 04:57:33 INFO - warning: no files found matching '*.txt' 04:57:33 INFO - no previously-included directories found matching 'build' 04:57:33 INFO - no previously-included directories found matching 'dist' 04:57:33 INFO - no previously-included directories found matching '.git*' 04:57:33 INFO - Successfully installed jsonschema functools32 04:57:33 INFO - Cleaning up... 04:57:33 INFO - Return code: 0 04:57:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffbfb0c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, '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': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', '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 04:57:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:57:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:57:33 INFO - Using env: {'DISPLAY': ':0', 04:57:33 INFO - 'HOME': '/home/cltbld', 04:57:33 INFO - 'LANG': 'en_US.UTF-8', 04:57:33 INFO - 'LANGUAGE': 'en_US:en', 04:57:33 INFO - 'LOGNAME': 'cltbld', 04:57:33 INFO - 'MAIL': '/var/mail/cltbld', 04:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:33 INFO - 'MOZ_NO_REMOTE': '1', 04:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:33 INFO - 'NO_EM_RESTART': '1', 04:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:33 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:33 INFO - 'SHELL': '/bin/bash', 04:57:33 INFO - 'SHLVL': '1', 04:57:33 INFO - 'TERM': 'linux', 04:57:33 INFO - 'TMOUT': '86400', 04:57:33 INFO - 'USER': 'cltbld', 04:57:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:33 INFO - '_': '/tools/buildbot/bin/python'} 04:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:33 INFO - Downloading/unpacking flake8 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:57:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:57:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:57:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 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 04:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:57:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:35 INFO - no previously-included directories found matching 'docs/_build' 04:57:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:35 INFO - Running setup.py install for pep8 04:57:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:35 INFO - no previously-included directories found matching 'docs/_build' 04:57:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:57:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:35 INFO - Cleaning up... 04:57:36 INFO - Return code: 0 04:57:36 INFO - Running post-action listener: _resource_record_post_action 04:57:36 INFO - Running post-action listener: _start_resource_monitoring 04:57:36 INFO - Starting resource monitoring. 04:57:36 INFO - ##### 04:57:36 INFO - ##### Running install step. 04:57:36 INFO - ##### 04:57:36 INFO - Running pre-action listener: _resource_record_pre_action 04:57:36 INFO - Running main action method: install 04:57:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:57:36 INFO - Reading from file tmpfile_stdout 04:57:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:57:36 INFO - Reading from file tmpfile_stdout 04:57:36 INFO - Output received: 04:57:36 INFO - Usage: mozinstall [options] installer 04:57:36 INFO - Options: 04:57:36 INFO - -h, --help show this help message and exit 04:57:36 INFO - -d DEST, --destination=DEST 04:57:36 INFO - Directory to install application into. [default: 04:57:36 INFO - "/builds/slave/test-pgo"] 04:57:36 INFO - --app=APP Application being installed. [default: firefox] 04:57:36 INFO - mkdir: /builds/slave/test-pgo/build/application 04:57:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:57:52 INFO - Reading from file tmpfile_stdout 04:57:52 INFO - Output received: 04:57:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:57:52 INFO - Running post-action listener: _resource_record_post_action 04:57:52 INFO - ##### 04:57:52 INFO - ##### Running run-tests step. 04:57:52 INFO - ##### 04:57:52 INFO - Running pre-action listener: _resource_record_pre_action 04:57:52 INFO - Running main action method: run_tests 04:57:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:57:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:57:52 INFO - Python 2.7.3 04:57:52 INFO - Return code: 0 04:57:52 INFO - grabbing minidump binary from tooltool 04:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:52 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 0x1671660>, '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 0x1672560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1672a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:57:52 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 04:57:52 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 04:57:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:52 INFO - Return code: 0 04:57:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:57:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:57:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:57:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:57:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:57:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:57:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:57:53 INFO - Return code: 0 04:57:53 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/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:57:53 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/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 04:57:53 INFO - Using env: {'DISPLAY': ':0', 04:57:53 INFO - 'HOME': '/home/cltbld', 04:57:53 INFO - 'LANG': 'en_US.UTF-8', 04:57:53 INFO - 'LANGUAGE': 'en_US:en', 04:57:53 INFO - 'LOGNAME': 'cltbld', 04:57:53 INFO - 'MAIL': '/var/mail/cltbld', 04:57:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:57:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:53 INFO - 'MOZ_NO_REMOTE': '1', 04:57:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:53 INFO - 'NO_EM_RESTART': '1', 04:57:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:57:53 INFO - 'SHELL': '/bin/bash', 04:57:53 INFO - 'SHLVL': '1', 04:57:53 INFO - 'TERM': 'linux', 04:57:53 INFO - 'TMOUT': '86400', 04:57:53 INFO - 'USER': 'cltbld', 04:57:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264', 04:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:53 INFO - '_': '/tools/buildbot/bin/python'} 04:57:53 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/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:57:53 INFO - mozversion application_buildid: 20160113023001 04:57:53 INFO - mozversion application_changeset: ac6d95e5a908a875b8bd87ca348832e443c9351f 04:57:53 INFO - mozversion application_display_name: Nightly 04:57:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:53 INFO - mozversion application_name: Firefox 04:57:53 INFO - mozversion application_remotingname: firefox 04:57:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:57:53 INFO - mozversion application_vendor: Mozilla 04:57:53 INFO - mozversion application_version: 46.0a1 04:57:53 INFO - mozversion platform_buildid: 20160113023001 04:57:53 INFO - mozversion platform_changeset: ac6d95e5a908a875b8bd87ca348832e443c9351f 04:57:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:57:53 INFO - mozversion platform_version: 46.0a1 04:57:53 INFO - using testdate: 1452689873 04:57:53 INFO - actual date: 1452689873 04:57:53 INFO - starting webserver on 'localhost:33304' 04:57:53 INFO - SUITE-START | Running 3 tests 04:57:53 INFO - TEST-START | dromaeo_css 04:57:53 INFO - operating with platform_type : linux_ 04:57:53 INFO - Initialising browser for dromaeo_css test... 04:57:53 INFO - TEST-INFO | started process 987 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIblLMo/profile http://localhost:33304/getInfo.html) 04:57:57 INFO - PROCESS | 987 | __metrics Screen width/height:1600/1200 04:57:57 INFO - PROCESS | 987 | colorDepth:24 04:57:57 INFO - PROCESS | 987 | Browser inner width/height: 1024/697 04:57:57 INFO - PROCESS | 987 | __metrics 04:57:57 INFO - PROCESS | 987 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:57:57 INFO - PROCESS | 987 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:58 INFO - TEST-INFO | 987: exit 0 04:57:58 INFO - Browser initialized. 04:57:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:58 INFO - TEST-INFO | started process 1094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIblLMo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:10 INFO - PROCESS | 1094 | RSS: Main: 147906560 04:58:10 INFO - PROCESS | 1094 | 04:59:02 INFO - PROCESS | 1094 | 1452689942153 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:01:10 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33304/tests/dromaeo/cssquery-ext.html) 05:01:11 INFO - PROCESS | 1094 | RSS: Main: 269758464 05:01:11 INFO - PROCESS | 1094 | 05:04:14 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-ext.html (next: http://localhost:33304/tests/dromaeo/cssquery-jquery.html) 05:04:14 INFO - PROCESS | 1094 | RSS: Main: 233787392 05:04:14 INFO - PROCESS | 1094 | 05:07:16 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33304/tests/dromaeo/cssquery-mootools.html) 05:07:17 INFO - PROCESS | 1094 | RSS: Main: 243277824 05:07:17 INFO - PROCESS | 1094 | 05:10:19 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33304/tests/dromaeo/cssquery-prototype.html) 05:10:19 INFO - PROCESS | 1094 | RSS: Main: 213323776 05:10:19 INFO - PROCESS | 1094 | 05:13:22 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33304/tests/dromaeo/cssquery-yui.html) 05:13:22 INFO - PROCESS | 1094 | RSS: Main: 217538560 05:13:22 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | Cycle 1(1): loaded http://localhost:33304/tests/dromaeo/cssquery-yui.html (next: http://localhost:33304/tests/dromaeo/cssquery-dojo.html) 05:16:25 INFO - PROCESS | 1094 | RSS: Main: 267714560 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | __start_tp_report 05:16:25 INFO - PROCESS | 1094 | _x_x_mozilla_page_load 05:16:25 INFO - PROCESS | 1094 | _x_x_mozilla_page_load_details 05:16:25 INFO - PROCESS | 1094 | |i|pagename|runs| 05:16:25 INFO - PROCESS | 1094 | |0;dojo.html;3115.4236466253747;3132.5144602586606;3169.239382548189;3171.0803866878605;3191.250056236784;4956.776945037473;5075.974620126899;5079.720615366154;5102.795888164469;5122.7950881964725;4990.700557966525;5012.523810238031;5076.568491678212;5150.871228219296;5162.432132465426;4639.234526303165;4672.672912896099;4679.3682852814945;4725.362076119714;4769.451513075988;4633.397658304416;4704.435467743876;4745.122152401799;4755.90488190236;4781.019890922353;4604.470485894098;4691.272852707836;4708.9058218835435;4754.690945088575;4762.404699412574;4655.324977878223;4657.836975705834;4669.229577119771;4672.15901137795;4677.041206552649;4631.3284573736955;4634.698744581625;4635.559621835921;4636.258198688228;4640.118377508263;4961.727105009223;5016.648834581581;5019.698818070928;5024.623153263483;5033.974830125862;5395.5953303502;5402.648827826218;5412.91880621791;5418.539424148952;5447.264619276387;5298.947010529884;5388.649737767033;5447.046766815792;5448.4279150689;5449.727513624303;5068.56917162038;5093.261477085802;5105.5915526758145;5135.563477104413;5157.48425157485;5464.3442786865035;5468.48049435303;5471.5896307777075;5473.17902314656;5478.753456094485;5245.318108645852;5258.158694608845;5261.973690131525;5276.577873770089;5300.893982120413;5364.463553644604;5385.838424847261;5438;5441.129419292894;5485.0949593317455;5402.243685883979;5402.567794576425;5406.486383793534;5407.594430417735;5420.728963551806;5317.946820531823;5400.135978243462;5409.702466364388;5410.540104091197;5454.91817622736;4242.087951090531;4259.446271984622;4279;4283.2932566126865;4316.179925814085;3831.214601006787;3840.9807950960626;3846.9615303847163;3866.9365924371023;3874.3219936511;4932.827351042696;5017.623678224148;5027.874303142451;5048.621353398436;5089.9745501272255;5435.320584926884;5479.123340265618;5503.367112782082;5517.172424136412;5542.889142217133;4991.326170966946;5012;5026.472220416877;5030.245463180552;5071.568916642127;4588.862334129982;4625.930611040837;4637.559431853969;4643.698159619614;4700.647451441156;5646.8023619173955;5674.0637794764225;5676.574256930747;5680.289963754531;5694.943050569441;5480.205370221375;5501.944980550304;5502.367227768697;5502.972485137549;5504.091824848855;5514.972425137848;5580.592195555341;5594.244776955222;5596.468335508121;5629.043062679272;5283.260343551829;5358.490943360374;5359.464053594609;5362.222477740784;5404.972975135099;5423.701696406735;5427.213054107054;5433.782648694166;5435.619506634655;5471.425500322568;5293.602979776455;5316.043112239679;5319.707416092152;5347.27811745425;5370.892582148257;5351.759170837399;5369.328833895763;5375.81184658535;5377.838664839905;5391.541718953933;5174.327337446108;5203.661761985459;5217.139172036723;5230.450802665665;5251.291075704731;5217.321748172713;5227.477252274742;5284.101702710472;5298.655587386807;5330.946690533045;5186.066508028591;5213.6350455467755;5216.556592689512;5217.6086793491395;5230.529252367305 05:16:25 INFO - PROCESS | 1094 | |1;ext.html;527.9472052794721;528.1654985123505;534.8154886564134;552.1193696054792;556.791203298763;27322.180334589946;28787;35979.280414391695;36474.08814779632;36517.26965460689;37754.811225943835;38035.61964380362;38218;38391.80804095975;38470.42294365587;8431.409801313926;8628.741137765877;8633.309335253196;8638.827223455528;8643.049264580892;8417.873731894026;8535.95732021339;8536.530490823003;8543.231109200171;8562.272206862424;8682.479051256912;8757.299416046733;8773.605187766565;8775.385722999361;8776.956115219447;8647.783805404915;8651.178138076873;8737.650493980296;8739.563021848882;8753.912460875374;8465.32277417805;8525.44584601999;8603.182697643713;8603.870941935877;8610.784730381727;39432.21135577301;39815.20369592592;39948.60051399478;40015.39976900349;40037.19925601472;3279.4097062528735;3513.4027215373194;3986.1230529283803;4008.098177909976;4023.2959232134554;29556.556651650244;29992.70007299921;30015.549766753516;30084.398312033856;31007.379852402824;2766.1701489553257;2815.211740712604;2837.2481292457514;2919;3085.9970509584473;251019;251539;251933;252052.73973630197;253277;51801;52732.47267527276;56356.718216408655;58561.41438585645;59334.70332648309;54533.45466545284;54727.452725472234;54781.72609136929;54798;55008.449915501136;12865.03512236586;12952.093353465356;12970.156939798882;12971.805422918664;12986.415611297514;9459.195968342769;9824.803503930025;10475.738106547396;10636.521356538975;10639.787204255872;19187.424377268704;19311.420657380302;19380;19388.8061119387;19415.708764368545;7034.577925324497;7152.642367881689;7165;7194.208637050025;7271.818204544928;926.0924294191595;947.7488465556632;963.3449254506862;988.836841921075;1003.4330603209163;29350.853245733633;30871.845640772102;31525;31565.210869728442;31860.522092168638;901.6753968571309;943.104051151409;951.6288647427509;979.8579206015088;1016.7356487313352;14617.488387906373;14625.414983400759;14696.632584185481;14805.62985925339;14887.18120503361;330231;335575;336018;336785;337081;51472.22791658053;52457.7377113112;52473.47526524762;52491.47508524866;52492.475075249524;1280.1742875845214;1303.6349822049842;1306.8693130686854;1311.141202512356;1321.933903304831;27679.72320276852;28339.57490637601;28554.286142846595;28647.283817903884;28650.283742906595;46651.30023049725;47043.29435058408;47055.29417058815;47063.76468117638;47120.528794711616;287016;294718;307695;400977;412495;30808.53787193149;30987.535186971763;31025.224369390944;31071.223219419695;31410.371792564478;43210.56789432065;43374.78312608417;43697.344539832564;44366.33450498181;44705.77647111744;36520.45219321766;37208;37458.812705936296;37848;38169.236615266986;35186.47220291749;36434.685153778635;37090;37253.25493490169;37257;32337.51493727549;32803.67196328102;32870.835645821615;33040.1739956503;36044.63955360413;30520.847395762878;31804.840975794974;32314.676853231165;32318.515222272155;32423;24217.878910605334;24967.71974255566;26403;26526.204213873614;26718.332041699112 05:16:25 INFO - PROCESS | 1094 | |2;jquery.html;356.61129368987815;357.06627169950576;357.8872655113639;362.4780316344464;364.3187239861459;13698.178109313449;13931.893181829511;16048.358065677374;16176.676466470664;16952;15452.84547154528;16105.03369797813;16536.338546458126;16832.495025149234;16835.66328673426;5253.789848406069;5447.618666693333;5449.836504904859;5450.700211488366;5451.781928722866;3973.543042550115;4138.875833724978;5361.51746342829;5440;5620.185073164389;5697.119950416373;5871.88256234875;5915.792947246847;5933.821985340425;5936.436038576328;5868.76524939002;5906.23218981534;5914.408559144051;5915.704214789265;5922.851928701795;5154.5103215194495;5179.948200517984;5921.319048309413;6167.383261673842;6176.382361763833;20260.290889818785;20589.691154632692;20862.478438039172;21590.1363945442;22048.228312009163;2234.229190929127;2260.9321720348416;2300.804431623314;2321.7330007049236;2399.460121472672;13494.730105397837;13946.302684865817;14085.436582536686;14244.21656808875;14702.411903523845;1852.8147185281498;1892.2052737850136;1922.1830721943118;1930.1025023364202;1961.08809403628;63402.682986585234;64701.352986470476;67159;67457;67513.32486675169;13860;14469.855301447062;14498.492552760603;14574.417023318949;14674;23433.88283058574;23539.882300588386;23545.411364715677;23657.52684946326;23712.525749484914;8244.793880153044;8298.21166989147;8342.791430214293;8357.8328433431;8374.916250837536;6881.965590172117;6885.586864788129;6928.861422771516;6941.236463988957;6950.895736563955;7457.47797654159;7474.5888976106835;7476.887846682304;7493.737719179802;7496.550206987598;1727.2486468386292;1797.6584448954657;1822.0798496759053;1826.4794533557872;2142.678598210281;861.543382007537;869.3002133282768;924.2236521322121;1025.5385076715509;1027.2501074215863;13943.511977080956;15379.46171884001;15618.141002244758;16489.175541222892;16587.751183732253;775.3642013548836;860.4622111180512;869.2698133567833;936.9625214991461;992.846108853129;8333.458325208963;8732.432391894507;8753.080926502626;8783.604737786814;8926.241269492037;482570;491840;505383;506429;508252;67983;68808.3119168802;69419.65290173517;71434;72516.63741681364;1081.464674985887;1098.6758906122714;1103.3710784852717;1113.6158025481195;1114.1532435349031;13735.24456154921;13894.722105558034;15340;15588.688226235185;15595.37618495293;31852;31861.68138318587;32567.511487327236;33208.50187247145;33419.498707519895;37433;38602;39136.412953806284;39212;39421;7058.435325173871;7334.3032411920785;7394.482386232912;7421.925780742339;7446.404287657083;9475.95262023713;11072.557097716;11370.772584548427;11383.03244224217;11555.191136620691;9802.264830137625;9849.86544308919;9852.211823054282;9884.950575247365;10019.949900250453;9729.9027009729;9876.259280553844;9954.352967057119;10030.197584193393;10043.397396156253;7503;9234.815303694022;9670.516474176122;9838.60645574169;9966.202703783534;6928.584284942919;7012.228654848064;7104.467164962752;7240.348368646847;7332.670029848777;9260;10013.2490063247;10131.848022279819;10163.644272450429;10258.692239232834 05:16:25 INFO - PROCESS | 1094 | |3;mootools.html;1317.7825658766303;1415.9150450972943;1432.405551696046;1566.9608259793504;1735.9826401735986;6388.3611638836155;7057.2942705729465;7157.28427157284;7172.569645821254;7188.173360063594;6954.756583519578;7064;7113.466490013244;7128.144622645277;7132.286771322865;2149.5593403352277;2172.619791536483;2174.3911704722705;2176.662617294322;2178.4989452425953;2168.8048075673187;2180.0952604669124;2229.253200177934;2230.5761905237955;2242.1143648258926;2223.7109175807122;2244.371575958734;2254.3124347074136;2255.0979608156786;2268.3648578398074;2184.8798316092607;2203.2398822406326;2208.8012078912816;2211.292386436341;2218.678291647718;2188.6607575825774;2190.9452263693374;2197.143114185469;2203.900824462903;2204.4488877780555;7242.963785181093;7262.527935684164;7271.600061996588;7315.743948961761;7332.670029848669;4473;4535.954640453586;4562.338460923181;4585.403897493338;4585.908281834345;2877.569788483776;3025.697430256979;3040.057582149541;3042.0417568465864;3063.127008802503;913.3971578757988;924.9121333473377;928.1600151862575;939.2110627073223;961.427950369529;10036.447995360253;10042.648507302283;10087.949560252151;10095.798084038279;10098.697039088765;4051.8987025324604;4073.2668119738137;4105.0763578195265;4126.711130220856;4196.223698615766;8555.700550480704;8587.871181932276;8610.268127209258;8617.827643447095;8623.267022303049;4636.072785442925;4638.582527572535;4646.3495110684535;4664.673472856867;4673.252279635242;3762.962370376316;3866.188100498927;4105;4246.532881383046;4260.957390426056;3540.5751309842985;3555.288942211568;3558.6797188252663;3586.1751797086818;3591.048372181374;1150.4477850631577;1179.1156632525606;1181.078758568318;1188.3345326617123;1191.66037679261;925.796324808541;941.6421759731395;944.3814301632442;979.9510024498746;1242.1243023668292;6429.067785171124;6542.54202205841;6565.048068030109;6578.111954886029;6580.473562115019;475.6765399528285;477.1435273683746;1174.8707642159357;1186.347508870118;1219.1222319929636;5191.117510023305;5299.33758280215;5302.2311764793885;5306.893862122736;5308.840734777963;8126.187381261945;8291.797689335013;8385.329173666092;8553.700620478254;8609.225169734755;8526.275266602284;8605.354598405145;8611.39720219591;8618.138186181457;8633.697820576375;6817.113775209191;6862.794116176523;6887.794635938691;6903.516753827284;7009.228984811667;6523.7716679915975;6621.702023409054;6622.90065649006;6625.50308726857;6636.900446493403;7810.687572497264;7865.646045927832;8091;8131.698928171464;8136.389770767098;8132;8256.587170641564;8285.378596605158;8359.164083591591;8379;5415.918761218663;5486.753096110605;5867.677277749594;6344.746210151727;6468.450181734605;6928.965355173192;6939.548929319578;6969;6983.9650801745665;6997.790066298019;6275.497960163085;6477.060826180272;6487.156669632917;6510.0885875976455;6557.737690492327;6224.315325314303;6326.715297811702;6356.936430635635;6404.391582799627;6458.580192287674;6348.428641422294;6513.088167656437;6515.087887695821;6516.250631177286;6520.869582608227;5841.649501029951;5955.40445955401;6029.909551356645;6052.6973651316375;6068.362821903636;6117.663528505975;6161.907571386343;6171.259448866164;6177.413145751147;6177.7837775677635 05:16:25 INFO - PROCESS | 1094 | |4;prototype.html;327.04339806067253;327.49729165730577;328.3777242126171;333.82474201044454;335.9093044877883;5865.501432378248;5875.148103524992;5904.793332233373;5911.5861889667685;5916.2900451945825;5635.492805647491;5695.231143795586;5760.711964401774;5823.272090988627;5840.53275737941;4492.460904691442;4507.594316511513;4512.278035514302;4517;4520.593146616804;4328.567143285662;4514.052049069699;4519.887002824923;4520.073384956093;4528.18492671319;4368.170047690945;4395.780210989437;4486.618637415823;4521.773911304438;4523.050159466499;4443.133588950156;4495.685302028859;4501.9870529130685;4526.864194074183;4532.048269863332;3976.224636195943;3976.741511801724;3978.6419222269847;3979;3979.621935916083;5461.18082287656;5572;5575.721213939287;5585.469380408855;5594.832155035356;5242.81650142247;5245.370555533361;5248.425472358315;5249.448807875195;5251.501107394792;6122.938770612282;6125.326214116443;6131.264248290234;6134.447899689049;6135.6625385603775;4404.625606823424;4404.911901761979;4406.25093734066;4407.845725399596;4409.889752756175;6255.718492667841;6406.4234218920055;6427.2287325520765;6431.871362572769;6466.224053113609;4516.961098947195;4525.502194758574;4527.84152554659;4528.275475923902;4531.614812740888;4585.977070114628;4586.656000799953;4588.908221835544;4589.403377560962;4589.609883159902;5231.738413079331;5236.581073514109;5246.055709972242;5247.16045432729;5252.9737351313;6108.602940808833;6222.875542489125;6226.501879849692;6227.532935029891;6230.501559875199;1606.7429211326132;1618.2556024228752;1618.886677932557;1623.2938671677857;1623.8132614749454;1071.9678409647722;1074.258761454594;1091.3615534912165;1094.392612100292;1103.5034234594464;5831.941680583224;5836.67898265591;5837.066069428871;5838.562107841929;5844.736986835603;6395.776147834897;6397.4562162216735;6400.263969643457;6400.455961243347;6402.711877965503;5661.575381846295;5828.854278643068;5830.183774271605;5831.125331200354;5846.1230815377185;3281.425750493654;3431.4509678451327;3455.1362159460136;3477.5305333779615;3487.7907325560545;6633.104530888365;6682.599044057372;6688.4649228061635;6703.262641109474;6714.29499902513;6571.967140164268;6587.901181482282;6600.273969863311;6610.0745895574655;6612.768553100618;6508.446782023581;6672.532922695462;6674.566153200027;6686.765963191265;6699.564528305645;6354.173957385695;6393.680315984089;6401.199850018747;6407.839804004937;6411.8717625646295;6328.683565821599;6354.936450635434;6367.968160159169;6380;6382.776602818879;6575.342465753386;6688.398044176048;6688.866222675617;6689.063531105552;6695.698693558704;4544;4544.545545445429;4546.386237857847;4548;4548.158590660738;6446.806595802133;6458.483321334376;6460.612363258031;6460.612363258219;6465.321141280286;6179.969100154471;6240.219972503437;6255.437010669061;6262.843428914313;6275.6548389839;6251.093591429309;6263.498920086291;6266.749330026748;6271.3728627136925;6279.560430769802;6167.229096362955;6169.105479705508;6172.074188871705;6173.59871608344;6174.722137503913;6096.969515152396;6172.629642221481;6229.50163986889;6299.559030867796;6302.936970630235;6070.514358851193;6072.605280656743;6087.086936959491;6087.117367981529;6207.782727604512 05:16:25 INFO - PROCESS | 1094 | |5;yui.html;720.1430297945446;747.6897087708601;770.907491101068;779.754377371128;779.814681683841;13134.540291089814;13237.271950042743;13301.13542619729;13339.7332053359;13345.199288042724;11773.293602383841;12264.264144151335;12294.692632684188;12321.445534950926;12334.5066197352;641.8459569703273;652.3932742549428;774.3843644302793;782.5695867272977;790.6284046498137;784.1609477858693;788.7909703928464;789.9763007109796;790.2137373313561;790.8576456237874;676.0501495398972;683.6547543490531;831.1024093978489;831.1107115386538;831.4013909984801;818.9140140285274;821.4660470694037;823.279630323467;824.0688022534498;824.431142511665;606.5299392970439;606.7087797857009;608.4767100293744;611.853155242743;613.8005148326768;11888.405579720978;11911.344876031815;11915;11924.165308428413;11936.104792140624;12541.811872821914;12806.61580152597;12893.871061289361;13135.934320328433;13176.934115329457;10126.54430550627;10203.744906377326;10567.418791966438;10778.353298802096;11726.179167458282;4259.084296876155;4277.529471758104;4333.566643335673;4457.888552786207;4464.330350447426;47278.05443891103;48410.51589484095;48592.27111593329;48708.26937595939;49049.75475122637;9292.210162136294;9374.203192728695;9486.620535178654;9997.80004399908;10123.03831136041;18185.090745462672;18352;18364.35724749654;18401.90799045996;18408.53978650518;7644.503107298008;7677.692892284358;7718.961405192938;7763.378929685611;8151.673933042612;4135.937960930589;4230.978845105755;4259.850905218303;4276.465441819772;4336.981369724469;2954.3795802881205;2999.2651800309063;3013.804102733315;3017.3814368054495;3017.969820301769;537.4679067722926;549.6097770582851;550.3231025838242;552.1166134185271;556.6187161794184;459.5037359651568;485.3472080052324;496.29030486404787;649.389573800626;663.787587971854;6992.720291188397;7529.924700753032;7614.771556853303;7699;8398.328133749286;538.5153361974254;540.4514417865869;554.6394843351853;556.3574071946827;574.8907707535554;3724.1434470071495;3936.4488971544006;4022.155347377025;4140.3168477201525;4217.910403081364;52667.68330791761;53715.73142134264;54262.728686357106;55478.16782748262;56119.15821262684;48187.518124819006;49408.50591494111;49960;50000.74999624979;50068;43485.08634222935;43532.56467435285;43544.34683479751;44188.116237675065;44243.55756442459;8042.155573664915;8091.595420228848;8125.8374832504205;8381.748547543584;8386.035605905156;33523.4971475433;34080.829595852854;34366.82816585901;35457.29085418329;35909.922702318974;42061.57938420577;42663.7866810664;42667.57332426636;42768.35847462353;43595.56404436042;10350.896491035295;10540.367577945348;10644.308119972176;10773.299735517166;10991.06575941054;11501.654950351503;11879.58421455245;11881.94059029734;11882.346470943836;11948.044156467287;10923.235373524094;11281.548738050386;11495.597654082067;11667.416629168338;11700.765984680429;10927.890721092688;11067.889321106686;11081.667549973514;11459.770804584028;11696.415179241174;10322.329048611817;10333.84499232497;10457.111145552713;10697.251192416456;10719.624813131502;8976.596053177493;9254.167124958785;9490.925807483078;9549.188318992685;9685.70942871715;8657.22085012352;9077;9139.360244782802;9283.72148835536;9715.757106072404 05:16:25 INFO - PROCESS | 1094 | __end_tp_report 05:16:25 INFO - PROCESS | 1094 | __start_cc_report 05:16:25 INFO - PROCESS | 1094 | _x_x_mozilla_cycle_collect,1006 05:16:25 INFO - PROCESS | 1094 | __end_cc_report 05:16:25 INFO - PROCESS | 1094 | __startTimestamp1452690985728__endTimestamp 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | ------- Summary: start ------- 05:16:25 INFO - PROCESS | 1094 | Number of tests: 6 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#0] dojo.html Cycles:165 Average:5057.81 Median:5217.61 stddev:523.33 (10.0%) stddev-sans-first:502.26 05:16:25 INFO - PROCESS | 1094 | Values: 3115.4 3132.5 3169.2 3171.1 3191.3 4956.8 5076.0 5079.7 5102.8 5122.8 4990.7 5012.5 5076.6 5150.9 5162.4 4639.2 4672.7 4679.4 4725.4 4769.5 4633.4 4704.4 4745.1 4755.9 4781.0 4604.5 4691.3 4708.9 4754.7 4762.4 4655.3 4657.8 4669.2 4672.2 4677.0 4631.3 4634.7 4635.6 4636.3 4640.1 4961.7 5016.6 5019.7 5024.6 5034.0 5395.6 5402.6 5412.9 5418.5 5447.3 5298.9 5388.6 5447.0 5448.4 5449.7 5068.6 5093.3 5105.6 5135.6 5157.5 5464.3 5468.5 5471.6 5473.2 5478.8 5245.3 5258.2 5262.0 5276.6 5300.9 5364.5 5385.8 5438.0 5441.1 5485.1 5402.2 5402.6 5406.5 5407.6 5420.7 5317.9 5400.1 5409.7 5410.5 5454.9 4242.1 4259.4 4279.0 4283.3 4316.2 3831.2 3841.0 3847.0 3866.9 3874.3 4932.8 5017.6 5027.9 5048.6 5090.0 5435.3 5479.1 5503.4 5517.2 5542.9 4991.3 5012.0 5026.5 5030.2 5071.6 4588.9 4625.9 4637.6 4643.7 4700.6 5646.8 5674.1 5676.6 5680.3 5694.9 5480.2 5501.9 5502.4 5503.0 5504.1 5515.0 5580.6 5594.2 5596.5 5629.0 5283.3 5358.5 5359.5 5362.2 5405.0 5423.7 5427.2 5433.8 5435.6 5471.4 5293.6 5316.0 5319.7 5347.3 5370.9 5351.8 5369.3 5375.8 5377.8 5391.5 5174.3 5203.7 5217.1 5230.5 5251.3 5217.3 5227.5 5284.1 5298.7 5330.9 5186.1 5213.6 5216.6 5217.6 5230.5 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#1] ext.html Cycles:180 Average:47112.98 Median:37255.13 stddev:82304.36 (220.9%) stddev-sans-first:82460.93 05:16:25 INFO - PROCESS | 1094 | Values: 527.9 528.2 534.8 552.1 556.8 27322.2 28787.0 35979.3 36474.1 36517.3 37754.8 38035.6 38218.0 38391.8 38470.4 8431.4 8628.7 8633.3 8638.8 8643.0 8417.9 8536.0 8536.5 8543.2 8562.3 8682.5 8757.3 8773.6 8775.4 8777.0 8647.8 8651.2 8737.7 8739.6 8753.9 8465.3 8525.4 8603.2 8603.9 8610.8 39432.2 39815.2 39948.6 40015.4 40037.2 3279.4 3513.4 3986.1 4008.1 4023.3 29556.6 29992.7 30015.5 30084.4 31007.4 2766.2 2815.2 2837.2 2919.0 3086.0 251019.0 251539.0 251933.0 252052.7 253277.0 51801.0 52732.5 56356.7 58561.4 59334.7 54533.5 54727.5 54781.7 54798.0 55008.4 12865.0 12952.1 12970.2 12971.8 12986.4 9459.2 9824.8 10475.7 10636.5 10639.8 19187.4 19311.4 19380.0 19388.8 19415.7 7034.6 7152.6 7165.0 7194.2 7271.8 926.1 947.7 963.3 988.8 1003.4 29350.9 30871.8 31525.0 31565.2 31860.5 901.7 943.1 951.6 979.9 1016.7 14617.5 14625.4 14696.6 14805.6 14887.2 330231.0 335575.0 336018.0 336785.0 337081.0 51472.2 52457.7 52473.5 52491.5 52492.5 1280.2 1303.6 1306.9 1311.1 1321.9 27679.7 28339.6 28554.3 28647.3 28650.3 46651.3 47043.3 47055.3 47063.8 47120.5 287016.0 294718.0 307695.0 400977.0 412495.0 30808.5 30987.5 31025.2 31071.2 31410.4 43210.6 43374.8 43697.3 44366.3 44705.8 36520.5 37208.0 37458.8 37848.0 38169.2 35186.5 36434.7 37090.0 37253.3 37257.0 32337.5 32803.7 32870.8 33040.2 36044.6 30520.8 31804.8 32314.7 32318.5 32423.0 24217.9 24967.7 26403.0 26526.2 26718.3 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#2] jquery.html Cycles:180 Average:27074.33 Median:487205.00 stddev:81509.93 (16.7%) stddev-sans-first:81713.89 05:16:25 INFO - PROCESS | 1094 | Values: 356.6 357.1 357.9 362.5 364.3 13698.2 13931.9 16048.4 16176.7 16952.0 15452.8 16105.0 16536.3 16832.5 16835.7 5253.8 5447.6 5449.8 5450.7 5451.8 3973.5 4138.9 5361.5 5440.0 5620.2 5697.1 5871.9 5915.8 5933.8 5936.4 5868.8 5906.2 5914.4 5915.7 5922.9 5154.5 5179.9 5921.3 6167.4 6176.4 20260.3 20589.7 20862.5 21590.1 22048.2 2234.2 2260.9 2300.8 2321.7 2399.5 13494.7 13946.3 14085.4 14244.2 14702.4 1852.8 1892.2 1922.2 1930.1 1961.1 63402.7 64701.4 67159.0 67457.0 67513.3 13860.0 14469.9 14498.5 14574.4 14674.0 23433.9 23539.9 23545.4 23657.5 23712.5 8244.8 8298.2 8342.8 8357.8 8374.9 6882.0 6885.6 6928.9 6941.2 6950.9 7457.5 7474.6 7476.9 7493.7 7496.6 1727.2 1797.7 1822.1 1826.5 2142.7 861.5 869.3 924.2 1025.5 1027.3 13943.5 15379.5 15618.1 16489.2 16587.8 775.4 860.5 869.3 937.0 992.8 8333.5 8732.4 8753.1 8783.6 8926.2 482570.0 491840.0 505383.0 506429.0 508252.0 67983.0 68808.3 69419.7 71434.0 72516.6 1081.5 1098.7 1103.4 1113.6 1114.2 13735.2 13894.7 15340.0 15588.7 15595.4 31852.0 31861.7 32567.5 33208.5 33419.5 37433.0 38602.0 39136.4 39212.0 39421.0 7058.4 7334.3 7394.5 7421.9 7446.4 9476.0 11072.6 11370.8 11383.0 11555.2 9802.3 9849.9 9852.2 9885.0 10019.9 9729.9 9876.3 9954.4 10030.2 10043.4 7503.0 9234.8 9670.5 9838.6 9966.2 6928.6 7012.2 7104.5 7240.3 7332.7 9260.0 10013.2 10131.8 10163.6 10258.7 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#3] mootools.html Cycles:180 Average:5095.79 Median:6166.58 stddev:2598.66 (42.1%) stddev-sans-first:2590.43 05:16:25 INFO - PROCESS | 1094 | Values: 1317.8 1415.9 1432.4 1567.0 1736.0 6388.4 7057.3 7157.3 7172.6 7188.2 6954.8 7064.0 7113.5 7128.1 7132.3 2149.6 2172.6 2174.4 2176.7 2178.5 2168.8 2180.1 2229.3 2230.6 2242.1 2223.7 2244.4 2254.3 2255.1 2268.4 2184.9 2203.2 2208.8 2211.3 2218.7 2188.7 2190.9 2197.1 2203.9 2204.4 7243.0 7262.5 7271.6 7315.7 7332.7 4473.0 4536.0 4562.3 4585.4 4585.9 2877.6 3025.7 3040.1 3042.0 3063.1 913.4 924.9 928.2 939.2 961.4 10036.4 10042.6 10087.9 10095.8 10098.7 4051.9 4073.3 4105.1 4126.7 4196.2 8555.7 8587.9 8610.3 8617.8 8623.3 4636.1 4638.6 4646.3 4664.7 4673.3 3763.0 3866.2 4105.0 4246.5 4261.0 3540.6 3555.3 3558.7 3586.2 3591.0 1150.4 1179.1 1181.1 1188.3 1191.7 925.8 941.6 944.4 980.0 1242.1 6429.1 6542.5 6565.0 6578.1 6580.5 475.7 477.1 1174.9 1186.3 1219.1 5191.1 5299.3 5302.2 5306.9 5308.8 8126.2 8291.8 8385.3 8553.7 8609.2 8526.3 8605.4 8611.4 8618.1 8633.7 6817.1 6862.8 6887.8 6903.5 7009.2 6523.8 6621.7 6622.9 6625.5 6636.9 7810.7 7865.6 8091.0 8131.7 8136.4 8132.0 8256.6 8285.4 8359.2 8379.0 5415.9 5486.8 5867.7 6344.7 6468.5 6929.0 6939.5 6969.0 6984.0 6997.8 6275.5 6477.1 6487.2 6510.1 6557.7 6224.3 6326.7 6356.9 6404.4 6458.6 6348.4 6513.1 6515.1 6516.3 6520.9 5841.6 5955.4 6029.9 6052.7 6068.4 6117.7 6161.9 6171.3 6177.4 6177.8 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#4] prototype.html Cycles:180 Average:5214.94 Median:5837.81 stddev:1552.46 (26.6%) stddev-sans-first:1512.84 05:16:25 INFO - PROCESS | 1094 | Values: 327.0 327.5 328.4 333.8 335.9 5865.5 5875.1 5904.8 5911.6 5916.3 5635.5 5695.2 5760.7 5823.3 5840.5 4492.5 4507.6 4512.3 4517.0 4520.6 4328.6 4514.1 4519.9 4520.1 4528.2 4368.2 4395.8 4486.6 4521.8 4523.1 4443.1 4495.7 4502.0 4526.9 4532.0 3976.2 3976.7 3978.6 3979.0 3979.6 5461.2 5572.0 5575.7 5585.5 5594.8 5242.8 5245.4 5248.4 5249.4 5251.5 6122.9 6125.3 6131.3 6134.4 6135.7 4404.6 4404.9 4406.3 4407.8 4409.9 6255.7 6406.4 6427.2 6431.9 6466.2 4517.0 4525.5 4527.8 4528.3 4531.6 4586.0 4586.7 4588.9 4589.4 4589.6 5231.7 5236.6 5246.1 5247.2 5253.0 6108.6 6222.9 6226.5 6227.5 6230.5 1606.7 1618.3 1618.9 1623.3 1623.8 1072.0 1074.3 1091.4 1094.4 1103.5 5831.9 5836.7 5837.1 5838.6 5844.7 6395.8 6397.5 6400.3 6400.5 6402.7 5661.6 5828.9 5830.2 5831.1 5846.1 3281.4 3431.5 3455.1 3477.5 3487.8 6633.1 6682.6 6688.5 6703.3 6714.3 6572.0 6587.9 6600.3 6610.1 6612.8 6508.4 6672.5 6674.6 6686.8 6699.6 6354.2 6393.7 6401.2 6407.8 6411.9 6328.7 6354.9 6368.0 6380.0 6382.8 6575.3 6688.4 6688.9 6689.1 6695.7 4544.0 4544.5 4546.4 4548.0 4548.2 6446.8 6458.5 6460.6 6460.6 6465.3 6180.0 6240.2 6255.4 6262.8 6275.7 6251.1 6263.5 6266.7 6271.4 6279.6 6167.2 6169.1 6172.1 6173.6 6174.7 6097.0 6172.6 6229.5 6299.6 6302.9 6070.5 6072.6 6087.1 6087.1 6207.8 05:16:25 INFO - PROCESS | 1094 | 05:16:25 INFO - PROCESS | 1094 | [#5] yui.html Cycles:180 Average:13393.74 Median:2461.92 stddev:15389.10 (625.1%) stddev-sans-first:15402.84 05:16:25 INFO - PROCESS | 1094 | Values: 720.1 747.7 770.9 779.8 779.8 13134.5 13237.3 13301.1 13339.7 13345.2 11773.3 12264.3 12294.7 12321.4 12334.5 641.8 652.4 774.4 782.6 790.6 784.2 788.8 790.0 790.2 790.9 676.1 683.7 831.1 831.1 831.4 818.9 821.5 823.3 824.1 824.4 606.5 606.7 608.5 611.9 613.8 11888.4 11911.3 11915.0 11924.2 11936.1 12541.8 12806.6 12893.9 13135.9 13176.9 10126.5 10203.7 10567.4 10778.4 11726.2 4259.1 4277.5 4333.6 4457.9 4464.3 47278.1 48410.5 48592.3 48708.3 49049.8 9292.2 9374.2 9486.6 9997.8 10123.0 18185.1 18352.0 18364.4 18401.9 18408.5 7644.5 7677.7 7719.0 7763.4 8151.7 4135.9 4231.0 4259.9 4276.5 4337.0 2954.4 2999.3 3013.8 3017.4 3018.0 537.5 549.6 550.3 552.1 556.6 459.5 485.3 496.3 649.4 663.8 6992.7 7529.9 7614.8 7699.0 8398.3 538.5 540.5 554.6 556.4 574.9 3724.1 3936.4 4022.2 4140.3 4217.9 52667.7 53715.7 54262.7 55478.2 56119.2 48187.5 49408.5 49960.0 50000.7 50068.0 43485.1 43532.6 43544.3 44188.1 44243.6 8042.2 8091.6 8125.8 8381.7 8386.0 33523.5 34080.8 34366.8 35457.3 35909.9 42061.6 42663.8 42667.6 42768.4 43595.6 10350.9 10540.4 10644.3 10773.3 10991.1 11501.7 11879.6 11881.9 11882.3 11948.0 10923.2 11281.5 11495.6 11667.4 11700.8 10927.9 11067.9 11081.7 11459.8 11696.4 10322.3 10333.8 10457.1 10697.3 10719.6 8976.6 9254.2 9490.9 9549.2 9685.7 8657.2 9077.0 9139.4 9283.7 9715.8 05:16:25 INFO - PROCESS | 1094 | -------- Summary: end -------- 05:16:25 INFO - PROCESS | 1094 | 05:16:26 INFO - TEST-INFO | 1094: exit 0 05:16:26 INFO - TEST-OK | dromaeo_css | took 1112754ms 05:16:26 INFO - TEST-START | kraken 05:16:26 INFO - operating with platform_type : linux_ 05:16:26 INFO - Initialising browser for kraken test... 05:16:26 INFO - TEST-INFO | started process 1353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBGW_r/profile http://localhost:33304/getInfo.html) 05:16:30 INFO - PROCESS | 1353 | __metrics Screen width/height:1600/1200 05:16:30 INFO - PROCESS | 1353 | colorDepth:24 05:16:30 INFO - PROCESS | 1353 | Browser inner width/height: 1024/697 05:16:30 INFO - PROCESS | 1353 | __metrics 05:16:30 INFO - PROCESS | 1353 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:16:30 INFO - PROCESS | 1353 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:16:31 INFO - TEST-INFO | 1353: exit 0 05:16:31 INFO - Browser initialized. 05:16:31 INFO - Running cycle 1/1 for kraken test... 05:16:31 INFO - TEST-INFO | started process 1437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBGW_r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:43 INFO - PROCESS | 1437 | RSS: Main: 148172800 05:16:43 INFO - PROCESS | 1437 | 05:16:45 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33304/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:46 INFO - PROCESS | 1437 | RSS: Main: 185946112 05:16:46 INFO - PROCESS | 1437 | 05:16:48 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33304/tests/kraken/driver.html?testName=audio-dft) 05:16:49 INFO - PROCESS | 1437 | RSS: Main: 175894528 05:16:49 INFO - PROCESS | 1437 | 05:16:52 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33304/tests/kraken/driver.html?testName=audio-fft) 05:16:52 INFO - PROCESS | 1437 | RSS: Main: 158969856 05:16:52 INFO - PROCESS | 1437 | 05:16:54 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33304/tests/kraken/driver.html?testName=audio-oscillator) 05:16:55 INFO - PROCESS | 1437 | RSS: Main: 162783232 05:16:55 INFO - PROCESS | 1437 | 05:16:57 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:58 INFO - PROCESS | 1437 | RSS: Main: 163938304 05:16:58 INFO - PROCESS | 1437 | 05:17:01 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33304/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:01 INFO - PROCESS | 1437 | RSS: Main: 163958784 05:17:01 INFO - PROCESS | 1437 | 05:17:05 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33304/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:05 INFO - PROCESS | 1437 | RSS: Main: 165519360 05:17:05 INFO - PROCESS | 1437 | 05:17:08 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33304/tests/kraken/driver.html?testName=json-parse-financial) 05:17:08 INFO - PROCESS | 1437 | RSS: Main: 164405248 05:17:08 INFO - PROCESS | 1437 | 05:17:10 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:11 INFO - PROCESS | 1437 | RSS: Main: 175194112 05:17:11 INFO - PROCESS | 1437 | 05:17:12 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:13 INFO - PROCESS | 1437 | RSS: Main: 173129728 05:17:13 INFO - PROCESS | 1437 | 05:17:15 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:16 INFO - PROCESS | 1437 | RSS: Main: 183578624 05:17:16 INFO - PROCESS | 1437 | 05:17:18 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:19 INFO - PROCESS | 1437 | RSS: Main: 188203008 05:17:19 INFO - PROCESS | 1437 | 05:17:21 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:22 INFO - PROCESS | 1437 | RSS: Main: 186707968 05:17:22 INFO - PROCESS | 1437 | 05:17:23 INFO - PROCESS | 1437 | Cycle 1(1): loaded http://localhost:33304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33304/tests/kraken/driver.html?testName=ai-astar) 05:17:24 INFO - PROCESS | 1437 | RSS: Main: 245403648 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | __start_tp_report 05:17:24 INFO - PROCESS | 1437 | _x_x_mozilla_page_load 05:17:24 INFO - PROCESS | 1437 | _x_x_mozilla_page_load_details 05:17:24 INFO - PROCESS | 1437 | |i|pagename|runs| 05:17:24 INFO - PROCESS | 1437 | |0;ai-astar;108;110;104;111;110;110;101;110;111;111 05:17:24 INFO - PROCESS | 1437 | |1;audio-beat-detection;161;130;154;166;124;149;151;125;166;129 05:17:24 INFO - PROCESS | 1437 | |2;audio-dft;161;162;162;161;160;165;161;161;162;160 05:17:24 INFO - PROCESS | 1437 | |3;audio-fft;71;71;87;93;74;73;72;104;97;75 05:17:24 INFO - PROCESS | 1437 | |4;audio-oscillator;107;96;140;97;103;97;136;97;96;142 05:17:24 INFO - PROCESS | 1437 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 05:17:24 INFO - PROCESS | 1437 | |6;imaging-darkroom;148;146;146;145;146;146;145;146;145;146 05:17:24 INFO - PROCESS | 1437 | |7;imaging-desaturate;96;96;97;96;96;95;96;96;95;95 05:17:24 INFO - PROCESS | 1437 | |8;json-parse-financial;56;55;55;57;54;56;57;65;52;54 05:17:24 INFO - PROCESS | 1437 | |9;json-stringify-tinderbox;67;68;68;68;69;70;68;68;68;69 05:17:24 INFO - PROCESS | 1437 | |10;stanford-crypto-aes;85;93;92;87;86;86;86;85;87;86 05:17:24 INFO - PROCESS | 1437 | |11;stanford-crypto-ccm;123;132;119;120;114;119;128;119;118;118 05:17:24 INFO - PROCESS | 1437 | |12;stanford-crypto-pbkdf2;151;142;153;160;144;143;152;143;150;146 05:17:24 INFO - PROCESS | 1437 | |13;stanford-crypto-sha256-iterative;69;68;69;69;67;67;67;67;70;67 05:17:24 INFO - PROCESS | 1437 | __end_tp_report 05:17:24 INFO - PROCESS | 1437 | __start_cc_report 05:17:24 INFO - PROCESS | 1437 | _x_x_mozilla_cycle_collect,939 05:17:24 INFO - PROCESS | 1437 | __end_cc_report 05:17:24 INFO - PROCESS | 1437 | __startTimestamp1452691044193__endTimestamp 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | ------- Summary: start ------- 05:17:24 INFO - PROCESS | 1437 | Number of tests: 14 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.41 (3.1%) stddev-sans-first:3.61 05:17:24 INFO - PROCESS | 1437 | Values: 108.0 110.0 104.0 111.0 110.0 110.0 101.0 110.0 111.0 111.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.50 stddev:16.97 (11.1%) stddev-sans-first:17.04 05:17:24 INFO - PROCESS | 1437 | Values: 161.0 130.0 154.0 166.0 124.0 149.0 151.0 125.0 166.0 129.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 05:17:24 INFO - PROCESS | 1437 | Values: 161.0 162.0 162.0 161.0 160.0 165.0 161.0 161.0 162.0 160.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.50 stddev:12.43 (16.7%) stddev-sans-first:12.56 05:17:24 INFO - PROCESS | 1437 | Values: 71.0 71.0 87.0 93.0 74.0 73.0 72.0 104.0 97.0 75.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:19.85 (20.7%) stddev-sans-first:20.99 05:17:24 INFO - PROCESS | 1437 | Values: 107.0 96.0 140.0 97.0 103.0 97.0 136.0 97.0 96.0 142.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:17:24 INFO - PROCESS | 1437 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.50 05:17:24 INFO - PROCESS | 1437 | Values: 148.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:17:24 INFO - PROCESS | 1437 | Values: 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:3.48 (6.2%) stddev-sans-first:3.69 05:17:24 INFO - PROCESS | 1437 | Values: 56.0 55.0 55.0 57.0 54.0 56.0 57.0 65.0 52.0 54.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 05:17:24 INFO - PROCESS | 1437 | Values: 67.0 68.0 68.0 68.0 69.0 70.0 68.0 68.0 68.0 69.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.50 stddev:2.83 (3.3%) stddev-sans-first:2.88 05:17:24 INFO - PROCESS | 1437 | Values: 85.0 93.0 92.0 87.0 86.0 86.0 86.0 85.0 87.0 86.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:119.50 stddev:5.31 (4.4%) stddev-sans-first:5.59 05:17:24 INFO - PROCESS | 1437 | Values: 123.0 132.0 119.0 120.0 114.0 119.0 128.0 119.0 118.0 118.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.50 stddev:5.80 (3.9%) stddev-sans-first:6.07 05:17:24 INFO - PROCESS | 1437 | Values: 151.0 142.0 153.0 160.0 144.0 143.0 152.0 143.0 150.0 146.0 05:17:24 INFO - PROCESS | 1437 | 05:17:24 INFO - PROCESS | 1437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 05:17:24 INFO - PROCESS | 1437 | Values: 69.0 68.0 69.0 69.0 67.0 67.0 67.0 67.0 70.0 67.0 05:17:24 INFO - PROCESS | 1437 | -------- Summary: end -------- 05:17:24 INFO - PROCESS | 1437 | 05:17:25 INFO - TEST-INFO | 1437: exit 0 05:17:25 INFO - TEST-OK | kraken | took 58760ms 05:17:25 INFO - TEST-START | v8_7 05:17:25 INFO - operating with platform_type : linux_ 05:17:25 INFO - Initialising browser for v8_7 test... 05:17:25 INFO - TEST-INFO | started process 1686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe1Te_H/profile http://localhost:33304/getInfo.html) 05:17:29 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 05:17:29 INFO - PROCESS | 1686 | colorDepth:24 05:17:29 INFO - PROCESS | 1686 | Browser inner width/height: 1024/697 05:17:29 INFO - PROCESS | 1686 | __metrics 05:17:29 INFO - PROCESS | 1686 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:17:29 INFO - PROCESS | 1686 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:30 INFO - TEST-INFO | 1686: exit 0 05:17:30 INFO - Browser initialized. 05:17:30 INFO - Running cycle 1/1 for v8_7 test... 05:17:30 INFO - TEST-INFO | started process 1766 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe1Te_H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:41 INFO - PROCESS | 1766 | RSS: Main: 148373504 05:17:41 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:33304/tests/v8_7/run.html (next: http://localhost:33304/tests/v8_7/run.html) 05:18:04 INFO - PROCESS | 1766 | RSS: Main: 561418240 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | __start_tp_report 05:18:04 INFO - PROCESS | 1766 | _x_x_mozilla_page_load 05:18:04 INFO - PROCESS | 1766 | _x_x_mozilla_page_load_details 05:18:04 INFO - PROCESS | 1766 | |i|pagename|runs| 05:18:04 INFO - PROCESS | 1766 | |0;Richards;169.92353440951572 05:18:04 INFO - PROCESS | 1766 | |1;DeltaBlue;197.55037534571315 05:18:04 INFO - PROCESS | 1766 | |2;Encrypt;285.06271379703537 05:18:04 INFO - PROCESS | 1766 | |3;Decrypt;5251.308900523561 05:18:04 INFO - PROCESS | 1766 | |4;RayTrace;1102.5358324145534 05:18:04 INFO - PROCESS | 1766 | |5;Earley;807.1025020177563 05:18:04 INFO - PROCESS | 1766 | |6;Boyer;12721.518987341773 05:18:04 INFO - PROCESS | 1766 | |7;RegExp;42770.833333333336 05:18:04 INFO - PROCESS | 1766 | |8;Splay;589.6531452087007 05:18:04 INFO - PROCESS | 1766 | |9;NavierStokes;4850.241545893719 05:18:04 INFO - PROCESS | 1766 | __end_tp_report 05:18:04 INFO - PROCESS | 1766 | __startTimestamp1452691084591__endTimestamp 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | ------- Summary: start ------- 05:18:04 INFO - PROCESS | 1766 | Number of tests: 10 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#0] Richards Cycles:1 Average:169.92 Median:169.92 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 169.9 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#1] DeltaBlue Cycles:1 Average:197.55 Median:197.55 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 197.6 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 285.1 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 5251.3 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 1102.5 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#5] Earley Cycles:1 Average:807.10 Median:807.10 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 807.1 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#6] Boyer Cycles:1 Average:12721.52 Median:12721.52 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 12721.5 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#7] RegExp Cycles:1 Average:42770.83 Median:42770.83 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 42770.8 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#8] Splay Cycles:1 Average:589.65 Median:589.65 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 589.7 05:18:04 INFO - PROCESS | 1766 | 05:18:04 INFO - PROCESS | 1766 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:18:04 INFO - PROCESS | 1766 | Values: 4850.2 05:18:04 INFO - PROCESS | 1766 | -------- Summary: end -------- 05:18:04 INFO - PROCESS | 1766 | 05:18:05 INFO - TEST-INFO | 1766: exit 0 05:18:05 INFO - TEST-OK | v8_7 | took 40366ms 05:18:05 INFO - SUITE-END | took 1211s 05:18:05 INFO - Completed test suite (00:20:11) 05:18:05 INFO - Working with test: dromaeo_css 05:18:05 INFO - Generating results file: dromaeo_css 05:18:05 INFO - Working with test: kraken 05:18:05 INFO - Generating results file: kraken 05:18:05 INFO - javascript benchmark 05:18:05 INFO - Working with test: v8_7 05:18:05 INFO - Generating results file: v8_7 05:18:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:18:05 INFO - process_Request line: dromaeo_css 6740.95 graph.html#tests=[[72,201,35]] 05:18:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - process_Request line: kraken 1508.20 graph.html#tests=[[232,201,35]] 05:18:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:05 INFO - process_Request line: v8_7 19765.46 graph.html#tests=[[230,201,35]] 05:18:05 INFO - RETURN: dromaeo_css: 6740.95 05:18:05 INFO - RETURN: kraken: 1508.20 05:18:05 INFO - RETURN: v8_7: 19765.46 05:18:05 INFO - javascript benchmark 05:18:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3115.4236466253747, 3132.5144602586606, 3169.239382548189, 3171.0803866878605, 3191.250056236784, 4956.776945037473, 5075.974620126899, 5079.720615366154, 5102.795888164469, 5122.7950881964725, 4990.700557966525, 5012.523810238031, 5076.568491678212, 5150.871228219296, 5162.432132465426, 4639.234526303165, 4672.672912896099, 4679.3682852814945, 4725.362076119714, 4769.451513075988, 4633.397658304416, 4704.435467743876, 4745.122152401799, 4755.90488190236, 4781.019890922353, 4604.470485894098, 4691.272852707836, 4708.9058218835435, 4754.690945088575, 4762.404699412574, 4655.324977878223, 4657.836975705834, 4669.229577119771, 4672.15901137795, 4677.041206552649, 4631.3284573736955, 4634.698744581625, 4635.559621835921, 4636.258198688228, 4640.118377508263, 4961.727105009223, 5016.648834581581, 5019.698818070928, 5024.623153263483, 5033.974830125862, 5395.5953303502, 5402.648827826218, 5412.91880621791, 5418.539424148952, 5447.264619276387, 5298.947010529884, 5388.649737767033, 5447.046766815792, 5448.4279150689, 5449.727513624303, 5068.56917162038, 5093.261477085802, 5105.5915526758145, 5135.563477104413, 5157.48425157485, 5464.3442786865035, 5468.48049435303, 5471.5896307777075, 5473.17902314656, 5478.753456094485, 5245.318108645852, 5258.158694608845, 5261.973690131525, 5276.577873770089, 5300.893982120413, 5364.463553644604, 5385.838424847261, 5438.0, 5441.129419292894, 5485.0949593317455, 5402.243685883979, 5402.567794576425, 5406.486383793534, 5407.594430417735, 5420.728963551806, 5317.946820531823, 5400.135978243462, 5409.702466364388, 5410.540104091197, 5454.91817622736, 4242.087951090531, 4259.446271984622, 4279.0, 4283.2932566126865, 4316.179925814085, 3831.214601006787, 3840.9807950960626, 3846.9615303847163, 3866.9365924371023, 3874.3219936511, 4932.827351042696, 5017.623678224148, 5027.874303142451, 5048.621353398436, 5089.9745501272255, 5435.320584926884, 5479.123340265618, 5503.367112782082, 5517.172424136412, 5542.889142217133, 4991.326170966946, 5012.0, 5026.472220416877, 5030.245463180552, 5071.568916642127, 4588.862334129982, 4625.930611040837, 4637.559431853969, 4643.698159619614, 4700.647451441156, 5646.8023619173955, 5674.0637794764225, 5676.574256930747, 5680.289963754531, 5694.943050569441, 5480.205370221375, 5501.944980550304, 5502.367227768697, 5502.972485137549, 5504.091824848855, 5514.972425137848, 5580.592195555341, 5594.244776955222, 5596.468335508121, 5629.043062679272, 5283.260343551829, 5358.490943360374, 5359.464053594609, 5362.222477740784, 5404.972975135099, 5423.701696406735, 5427.213054107054, 5433.782648694166, 5435.619506634655, 5471.425500322568, 5293.602979776455, 5316.043112239679, 5319.707416092152, 5347.27811745425, 5370.892582148257, 5351.759170837399, 5369.328833895763, 5375.81184658535, 5377.838664839905, 5391.541718953933, 5174.327337446108, 5203.661761985459, 5217.139172036723, 5230.450802665665, 5251.291075704731, 5217.321748172713, 5227.477252274742, 5284.101702710472, 5298.655587386807, 5330.946690533045, 5186.066508028591, 5213.6350455467755, 5216.556592689512, 5217.6086793491395, 5230.529252367305], "unit": "score", "name": "dojo.html", "value": 5026.474242801183}, {"lowerIsBetter": false, "replicates": [527.9472052794721, 528.1654985123505, 534.8154886564134, 552.1193696054792, 556.791203298763, 27322.180334589946, 28787.0, 35979.280414391695, 36474.08814779632, 36517.26965460689, 37754.811225943835, 38035.61964380362, 38218.0, 38391.80804095975, 38470.42294365587, 8431.409801313926, 8628.741137765877, 8633.309335253196, 8638.827223455528, 8643.049264580892, 8417.873731894026, 8535.95732021339, 8536.530490823003, 8543.231109200171, 8562.272206862424, 8682.479051256912, 8757.299416046733, 8773.605187766565, 8775.385722999361, 8776.956115219447, 8647.783805404915, 8651.178138076873, 8737.650493980296, 8739.563021848882, 8753.912460875374, 8465.32277417805, 8525.44584601999, 8603.182697643713, 8603.870941935877, 8610.784730381727, 39432.21135577301, 39815.20369592592, 39948.60051399478, 40015.39976900349, 40037.19925601472, 3279.4097062528735, 3513.4027215373194, 3986.1230529283803, 4008.098177909976, 4023.2959232134554, 29556.556651650244, 29992.70007299921, 30015.549766753516, 30084.398312033856, 31007.379852402824, 2766.1701489553257, 2815.211740712604, 2837.2481292457514, 2919.0, 3085.9970509584473, 251019.0, 251539.0, 251933.0, 252052.73973630197, 253277.0, 51801.0, 52732.47267527276, 56356.718216408655, 58561.41438585645, 59334.70332648309, 54533.45466545284, 54727.452725472234, 54781.72609136929, 54798.0, 55008.449915501136, 12865.03512236586, 12952.093353465356, 12970.156939798882, 12971.805422918664, 12986.415611297514, 9459.195968342769, 9824.803503930025, 10475.738106547396, 10636.521356538975, 10639.787204255872, 19187.424377268704, 19311.420657380302, 19380.0, 19388.8061119387, 19415.708764368545, 7034.577925324497, 7152.642367881689, 7165.0, 7194.208637050025, 7271.818204544928, 926.0924294191595, 947.7488465556632, 963.3449254506862, 988.836841921075, 1003.4330603209163, 29350.853245733633, 30871.845640772102, 31525.0, 31565.210869728442, 31860.522092168638, 901.6753968571309, 943.104051151409, 951.6288647427509, 979.8579206015088, 1016.7356487313352, 14617.488387906373, 14625.414983400759, 14696.632584185481, 14805.62985925339, 14887.18120503361, 330231.0, 335575.0, 336018.0, 336785.0, 337081.0, 51472.22791658053, 52457.7377113112, 52473.47526524762, 52491.47508524866, 52492.475075249524, 1280.1742875845214, 1303.6349822049842, 1306.8693130686854, 1311.141202512356, 1321.933903304831, 27679.72320276852, 28339.57490637601, 28554.286142846595, 28647.283817903884, 28650.283742906595, 46651.30023049725, 47043.29435058408, 47055.29417058815, 47063.76468117638, 47120.528794711616, 287016.0, 294718.0, 307695.0, 400977.0, 412495.0, 30808.53787193149, 30987.535186971763, 31025.224369390944, 31071.223219419695, 31410.371792564478, 43210.56789432065, 43374.78312608417, 43697.344539832564, 44366.33450498181, 44705.77647111744, 36520.45219321766, 37208.0, 37458.812705936296, 37848.0, 38169.236615266986, 35186.47220291749, 36434.685153778635, 37090.0, 37253.25493490169, 37257.0, 32337.51493727549, 32803.67196328102, 32870.835645821615, 33040.1739956503, 36044.63955360413, 30520.847395762878, 31804.840975794974, 32314.676853231165, 32318.515222272155, 32423.0, 24217.878910605334, 24967.71974255566, 26403.0, 26526.204213873614, 26718.332041699112], "unit": "score", "name": "ext.html", "value": 17932.3193313031}, {"lowerIsBetter": false, "replicates": [356.61129368987815, 357.06627169950576, 357.8872655113639, 362.4780316344464, 364.3187239861459, 13698.178109313449, 13931.893181829511, 16048.358065677374, 16176.676466470664, 16952.0, 15452.84547154528, 16105.03369797813, 16536.338546458126, 16832.495025149234, 16835.66328673426, 5253.789848406069, 5447.618666693333, 5449.836504904859, 5450.700211488366, 5451.781928722866, 3973.543042550115, 4138.875833724978, 5361.51746342829, 5440.0, 5620.185073164389, 5697.119950416373, 5871.88256234875, 5915.792947246847, 5933.821985340425, 5936.436038576328, 5868.76524939002, 5906.23218981534, 5914.408559144051, 5915.704214789265, 5922.851928701795, 5154.5103215194495, 5179.948200517984, 5921.319048309413, 6167.383261673842, 6176.382361763833, 20260.290889818785, 20589.691154632692, 20862.478438039172, 21590.1363945442, 22048.228312009163, 2234.229190929127, 2260.9321720348416, 2300.804431623314, 2321.7330007049236, 2399.460121472672, 13494.730105397837, 13946.302684865817, 14085.436582536686, 14244.21656808875, 14702.411903523845, 1852.8147185281498, 1892.2052737850136, 1922.1830721943118, 1930.1025023364202, 1961.08809403628, 63402.682986585234, 64701.352986470476, 67159.0, 67457.0, 67513.32486675169, 13860.0, 14469.855301447062, 14498.492552760603, 14574.417023318949, 14674.0, 23433.88283058574, 23539.882300588386, 23545.411364715677, 23657.52684946326, 23712.525749484914, 8244.793880153044, 8298.21166989147, 8342.791430214293, 8357.8328433431, 8374.916250837536, 6881.965590172117, 6885.586864788129, 6928.861422771516, 6941.236463988957, 6950.895736563955, 7457.47797654159, 7474.5888976106835, 7476.887846682304, 7493.737719179802, 7496.550206987598, 1727.2486468386292, 1797.6584448954657, 1822.0798496759053, 1826.4794533557872, 2142.678598210281, 861.543382007537, 869.3002133282768, 924.2236521322121, 1025.5385076715509, 1027.2501074215863, 13943.511977080956, 15379.46171884001, 15618.141002244758, 16489.175541222892, 16587.751183732253, 775.3642013548836, 860.4622111180512, 869.2698133567833, 936.9625214991461, 992.846108853129, 8333.458325208963, 8732.432391894507, 8753.080926502626, 8783.604737786814, 8926.241269492037, 482570.0, 491840.0, 505383.0, 506429.0, 508252.0, 67983.0, 68808.3119168802, 69419.65290173517, 71434.0, 72516.63741681364, 1081.464674985887, 1098.6758906122714, 1103.3710784852717, 1113.6158025481195, 1114.1532435349031, 13735.24456154921, 13894.722105558034, 15340.0, 15588.688226235185, 15595.37618495293, 31852.0, 31861.68138318587, 32567.511487327236, 33208.50187247145, 33419.498707519895, 37433.0, 38602.0, 39136.412953806284, 39212.0, 39421.0, 7058.435325173871, 7334.3032411920785, 7394.482386232912, 7421.925780742339, 7446.404287657083, 9475.95262023713, 11072.557097716, 11370.772584548427, 11383.03244224217, 11555.191136620691, 9802.264830137625, 9849.86544308919, 9852.211823054282, 9884.950575247365, 10019.949900250453, 9729.9027009729, 9876.259280553844, 9954.352967057119, 10030.197584193393, 10043.397396156253, 7503.0, 9234.815303694022, 9670.516474176122, 9838.60645574169, 9966.202703783534, 6928.584284942919, 7012.228654848064, 7104.467164962752, 7240.348368646847, 7332.670029848777, 9260.0, 10013.2490063247, 10131.848022279819, 10163.644272450429, 10258.692239232834], "unit": "score", "name": "jquery.html", "value": 8620.444703067906}, {"lowerIsBetter": false, "replicates": [1317.7825658766303, 1415.9150450972943, 1432.405551696046, 1566.9608259793504, 1735.9826401735986, 6388.3611638836155, 7057.2942705729465, 7157.28427157284, 7172.569645821254, 7188.173360063594, 6954.756583519578, 7064.0, 7113.466490013244, 7128.144622645277, 7132.286771322865, 2149.5593403352277, 2172.619791536483, 2174.3911704722705, 2176.662617294322, 2178.4989452425953, 2168.8048075673187, 2180.0952604669124, 2229.253200177934, 2230.5761905237955, 2242.1143648258926, 2223.7109175807122, 2244.371575958734, 2254.3124347074136, 2255.0979608156786, 2268.3648578398074, 2184.8798316092607, 2203.2398822406326, 2208.8012078912816, 2211.292386436341, 2218.678291647718, 2188.6607575825774, 2190.9452263693374, 2197.143114185469, 2203.900824462903, 2204.4488877780555, 7242.963785181093, 7262.527935684164, 7271.600061996588, 7315.743948961761, 7332.670029848669, 4473.0, 4535.954640453586, 4562.338460923181, 4585.403897493338, 4585.908281834345, 2877.569788483776, 3025.697430256979, 3040.057582149541, 3042.0417568465864, 3063.127008802503, 913.3971578757988, 924.9121333473377, 928.1600151862575, 939.2110627073223, 961.427950369529, 10036.447995360253, 10042.648507302283, 10087.949560252151, 10095.798084038279, 10098.697039088765, 4051.8987025324604, 4073.2668119738137, 4105.0763578195265, 4126.711130220856, 4196.223698615766, 8555.700550480704, 8587.871181932276, 8610.268127209258, 8617.827643447095, 8623.267022303049, 4636.072785442925, 4638.582527572535, 4646.3495110684535, 4664.673472856867, 4673.252279635242, 3762.962370376316, 3866.188100498927, 4105.0, 4246.532881383046, 4260.957390426056, 3540.5751309842985, 3555.288942211568, 3558.6797188252663, 3586.1751797086818, 3591.048372181374, 1150.4477850631577, 1179.1156632525606, 1181.078758568318, 1188.3345326617123, 1191.66037679261, 925.796324808541, 941.6421759731395, 944.3814301632442, 979.9510024498746, 1242.1243023668292, 6429.067785171124, 6542.54202205841, 6565.048068030109, 6578.111954886029, 6580.473562115019, 475.6765399528285, 477.1435273683746, 1174.8707642159357, 1186.347508870118, 1219.1222319929636, 5191.117510023305, 5299.33758280215, 5302.2311764793885, 5306.893862122736, 5308.840734777963, 8126.187381261945, 8291.797689335013, 8385.329173666092, 8553.700620478254, 8609.225169734755, 8526.275266602284, 8605.354598405145, 8611.39720219591, 8618.138186181457, 8633.697820576375, 6817.113775209191, 6862.794116176523, 6887.794635938691, 6903.516753827284, 7009.228984811667, 6523.7716679915975, 6621.702023409054, 6622.90065649006, 6625.50308726857, 6636.900446493403, 7810.687572497264, 7865.646045927832, 8091.0, 8131.698928171464, 8136.389770767098, 8132.0, 8256.587170641564, 8285.378596605158, 8359.164083591591, 8379.0, 5415.918761218663, 5486.753096110605, 5867.677277749594, 6344.746210151727, 6468.450181734605, 6928.965355173192, 6939.548929319578, 6969.0, 6983.9650801745665, 6997.790066298019, 6275.497960163085, 6477.060826180272, 6487.156669632917, 6510.0885875976455, 6557.737690492327, 6224.315325314303, 6326.715297811702, 6356.936430635635, 6404.391582799627, 6458.580192287674, 6348.428641422294, 6513.088167656437, 6515.087887695821, 6516.250631177286, 6520.869582608227, 5841.649501029951, 5955.40445955401, 6029.909551356645, 6052.6973651316375, 6068.362821903636, 6117.663528505975, 6161.907571386343, 6171.259448866164, 6177.413145751147, 6177.7837775677635], "unit": "score", "name": "mootools.html", "value": 4203.891578791049}, {"lowerIsBetter": false, "replicates": [327.04339806067253, 327.49729165730577, 328.3777242126171, 333.82474201044454, 335.9093044877883, 5865.501432378248, 5875.148103524992, 5904.793332233373, 5911.5861889667685, 5916.2900451945825, 5635.492805647491, 5695.231143795586, 5760.711964401774, 5823.272090988627, 5840.53275737941, 4492.460904691442, 4507.594316511513, 4512.278035514302, 4517.0, 4520.593146616804, 4328.567143285662, 4514.052049069699, 4519.887002824923, 4520.073384956093, 4528.18492671319, 4368.170047690945, 4395.780210989437, 4486.618637415823, 4521.773911304438, 4523.050159466499, 4443.133588950156, 4495.685302028859, 4501.9870529130685, 4526.864194074183, 4532.048269863332, 3976.224636195943, 3976.741511801724, 3978.6419222269847, 3979.0, 3979.621935916083, 5461.18082287656, 5572.0, 5575.721213939287, 5585.469380408855, 5594.832155035356, 5242.81650142247, 5245.370555533361, 5248.425472358315, 5249.448807875195, 5251.501107394792, 6122.938770612282, 6125.326214116443, 6131.264248290234, 6134.447899689049, 6135.6625385603775, 4404.625606823424, 4404.911901761979, 4406.25093734066, 4407.845725399596, 4409.889752756175, 6255.718492667841, 6406.4234218920055, 6427.2287325520765, 6431.871362572769, 6466.224053113609, 4516.961098947195, 4525.502194758574, 4527.84152554659, 4528.275475923902, 4531.614812740888, 4585.977070114628, 4586.656000799953, 4588.908221835544, 4589.403377560962, 4589.609883159902, 5231.738413079331, 5236.581073514109, 5246.055709972242, 5247.16045432729, 5252.9737351313, 6108.602940808833, 6222.875542489125, 6226.501879849692, 6227.532935029891, 6230.501559875199, 1606.7429211326132, 1618.2556024228752, 1618.886677932557, 1623.2938671677857, 1623.8132614749454, 1071.9678409647722, 1074.258761454594, 1091.3615534912165, 1094.392612100292, 1103.5034234594464, 5831.941680583224, 5836.67898265591, 5837.066069428871, 5838.562107841929, 5844.736986835603, 6395.776147834897, 6397.4562162216735, 6400.263969643457, 6400.455961243347, 6402.711877965503, 5661.575381846295, 5828.854278643068, 5830.183774271605, 5831.125331200354, 5846.1230815377185, 3281.425750493654, 3431.4509678451327, 3455.1362159460136, 3477.5305333779615, 3487.7907325560545, 6633.104530888365, 6682.599044057372, 6688.4649228061635, 6703.262641109474, 6714.29499902513, 6571.967140164268, 6587.901181482282, 6600.273969863311, 6610.0745895574655, 6612.768553100618, 6508.446782023581, 6672.532922695462, 6674.566153200027, 6686.765963191265, 6699.564528305645, 6354.173957385695, 6393.680315984089, 6401.199850018747, 6407.839804004937, 6411.8717625646295, 6328.683565821599, 6354.936450635434, 6367.968160159169, 6380.0, 6382.776602818879, 6575.342465753386, 6688.398044176048, 6688.866222675617, 6689.063531105552, 6695.698693558704, 4544.0, 4544.545545445429, 4546.386237857847, 4548.0, 4548.158590660738, 6446.806595802133, 6458.483321334376, 6460.612363258031, 6460.612363258219, 6465.321141280286, 6179.969100154471, 6240.219972503437, 6255.437010669061, 6262.843428914313, 6275.6548389839, 6251.093591429309, 6263.498920086291, 6266.749330026748, 6271.3728627136925, 6279.560430769802, 6167.229096362955, 6169.105479705508, 6172.074188871705, 6173.59871608344, 6174.722137503913, 6096.969515152396, 6172.629642221481, 6229.50163986889, 6299.559030867796, 6302.936970630235, 6070.514358851193, 6072.605280656743, 6087.086936959491, 6087.117367981529, 6207.782727604512], "unit": "score", "name": "prototype.html", "value": 4712.471823856819}, {"lowerIsBetter": false, "replicates": [720.1430297945446, 747.6897087708601, 770.907491101068, 779.754377371128, 779.814681683841, 13134.540291089814, 13237.271950042743, 13301.13542619729, 13339.7332053359, 13345.199288042724, 11773.293602383841, 12264.264144151335, 12294.692632684188, 12321.445534950926, 12334.5066197352, 641.8459569703273, 652.3932742549428, 774.3843644302793, 782.5695867272977, 790.6284046498137, 784.1609477858693, 788.7909703928464, 789.9763007109796, 790.2137373313561, 790.8576456237874, 676.0501495398972, 683.6547543490531, 831.1024093978489, 831.1107115386538, 831.4013909984801, 818.9140140285274, 821.4660470694037, 823.279630323467, 824.0688022534498, 824.431142511665, 606.5299392970439, 606.7087797857009, 608.4767100293744, 611.853155242743, 613.8005148326768, 11888.405579720978, 11911.344876031815, 11915.0, 11924.165308428413, 11936.104792140624, 12541.811872821914, 12806.61580152597, 12893.871061289361, 13135.934320328433, 13176.934115329457, 10126.54430550627, 10203.744906377326, 10567.418791966438, 10778.353298802096, 11726.179167458282, 4259.084296876155, 4277.529471758104, 4333.566643335673, 4457.888552786207, 4464.330350447426, 47278.05443891103, 48410.51589484095, 48592.27111593329, 48708.26937595939, 49049.75475122637, 9292.210162136294, 9374.203192728695, 9486.620535178654, 9997.80004399908, 10123.03831136041, 18185.090745462672, 18352.0, 18364.35724749654, 18401.90799045996, 18408.53978650518, 7644.503107298008, 7677.692892284358, 7718.961405192938, 7763.378929685611, 8151.673933042612, 4135.937960930589, 4230.978845105755, 4259.850905218303, 4276.465441819772, 4336.981369724469, 2954.3795802881205, 2999.2651800309063, 3013.804102733315, 3017.3814368054495, 3017.969820301769, 537.4679067722926, 549.6097770582851, 550.3231025838242, 552.1166134185271, 556.6187161794184, 459.5037359651568, 485.3472080052324, 496.29030486404787, 649.389573800626, 663.787587971854, 6992.720291188397, 7529.924700753032, 7614.771556853303, 7699.0, 8398.328133749286, 538.5153361974254, 540.4514417865869, 554.6394843351853, 556.3574071946827, 574.8907707535554, 3724.1434470071495, 3936.4488971544006, 4022.155347377025, 4140.3168477201525, 4217.910403081364, 52667.68330791761, 53715.73142134264, 54262.728686357106, 55478.16782748262, 56119.15821262684, 48187.518124819006, 49408.50591494111, 49960.0, 50000.74999624979, 50068.0, 43485.08634222935, 43532.56467435285, 43544.34683479751, 44188.116237675065, 44243.55756442459, 8042.155573664915, 8091.595420228848, 8125.8374832504205, 8381.748547543584, 8386.035605905156, 33523.4971475433, 34080.829595852854, 34366.82816585901, 35457.29085418329, 35909.922702318974, 42061.57938420577, 42663.7866810664, 42667.57332426636, 42768.35847462353, 43595.56404436042, 10350.896491035295, 10540.367577945348, 10644.308119972176, 10773.299735517166, 10991.06575941054, 11501.654950351503, 11879.58421455245, 11881.94059029734, 11882.346470943836, 11948.044156467287, 10923.235373524094, 11281.548738050386, 11495.597654082067, 11667.416629168338, 11700.765984680429, 10927.890721092688, 11067.889321106686, 11081.667549973514, 11459.770804584028, 11696.415179241174, 10322.329048611817, 10333.84499232497, 10457.111145552713, 10697.251192416456, 10719.624813131502, 8976.596053177493, 9254.167124958785, 9490.925807483078, 9549.188318992685, 9685.70942871715, 8657.22085012352, 9077.0, 9139.360244782802, 9283.72148835536, 9715.757106072404], "unit": "score", "name": "yui.html", "value": 6094.74437490083}], "name": "dromaeo_css", "value": 6740.949697431219}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 111.0, 110.0, 110.0, 101.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 154.0, 166.0, 124.0, 149.0, 151.0, 125.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 160.0, 165.0, 161.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 87.0, 93.0, 74.0, 73.0, 72.0, 104.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [107.0, 96.0, 140.0, 97.0, 103.0, 97.0, 136.0, 97.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 57.0, 54.0, 56.0, 57.0, 65.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 70.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 92.0, 87.0, 86.0, 86.0, 86.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [123.0, 132.0, 119.0, 120.0, 114.0, 119.0, 128.0, 119.0, 118.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [151.0, 142.0, 153.0, 160.0, 144.0, 143.0, 152.0, 143.0, 150.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 67.0, 67.0, 67.0, 67.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1508.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.92353440951572], "unit": "score", "name": "Richards", "value": 207.75227000000007}, {"lowerIsBetter": false, "replicates": [197.55037534571315], "unit": "score", "name": "DeltaBlue", "value": 334.689316}, {"lowerIsBetter": false, "replicates": [285.06271379703537], "unit": "score", "name": "Encrypt", "value": 933.7629479999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [807.1025020177563], "unit": "score", "name": "Earley", "value": 825.7476570000002}, {"lowerIsBetter": false, "replicates": [12721.518987341773], "unit": "score", "name": "Boyer", "value": 52.38863383084579}, {"lowerIsBetter": false, "replicates": [42770.833333333336], "unit": "score", "name": "RegExp", "value": 21.29921091086215}, {"lowerIsBetter": false, "replicates": [589.6531452087007], "unit": "score", "name": "Splay", "value": 138.2015862412762}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19765.460822924633}]} 05:18:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19765.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1508.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6740.95"}}} 05:18:05 INFO - Return code: 0 05:18:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:05 INFO - # TBPL SUCCESS # 05:18:05 INFO - Running post-action listener: _resource_record_post_action 05:18:05 INFO - Running post-run listener: _resource_record_post_run 05:18:06 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 411869184; Read time: 220; Write time: 349244 05:18:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 102899712; Read time: 176; Write time: 75856 05:18:06 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297836544; Read time: 44; Write time: 271960 05:18:06 INFO - Running post-run listener: _upload_blobber_files 05:18:06 INFO - Blob upload gear active. 05:18:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:18:06 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:18:06 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:18:06 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:18:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:08 INFO - (blobuploader) - INFO - Done attempting. 05:18:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:09 INFO - (blobuploader) - INFO - Done attempting. 05:18:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:09 INFO - Return code: 0 05:18:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:18:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a40dfb1680ebe386979d9ac556f270ea53c7895cc195e44c28e3f5bb6d367c5f5c0eb6969a0242dcd61f5877f274e1ce39c071d6b3f71e38224babe161a9d77e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bc6cb0317cac969a9de8717ea2cd33edfee6cf1a435797ad88c1d87acebb2ebf6d7abd2cf5f17a319bbdb4ccacc674c2c0fde189f8f9ba4b7578106d949ad776"} 05:18:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:18:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:18:09 INFO - Contents: 05:18:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a40dfb1680ebe386979d9ac556f270ea53c7895cc195e44c28e3f5bb6d367c5f5c0eb6969a0242dcd61f5877f274e1ce39c071d6b3f71e38224babe161a9d77e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bc6cb0317cac969a9de8717ea2cd33edfee6cf1a435797ad88c1d87acebb2ebf6d7abd2cf5f17a319bbdb4ccacc674c2c0fde189f8f9ba4b7578106d949ad776"} 05:18:09 INFO - Copying logs to upload dir... 05:18:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1302.296051 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-01-13 05:18:08.454738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:08.458528) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 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/a40dfb1680ebe386979d9ac556f270ea53c7895cc195e44c28e3f5bb6d367c5f5c0eb6969a0242dcd61f5877f274e1ce39c071d6b3f71e38224babe161a9d77e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bc6cb0317cac969a9de8717ea2cd33edfee6cf1a435797ad88c1d87acebb2ebf6d7abd2cf5f17a319bbdb4ccacc674c2c0fde189f8f9ba4b7578106d949ad776"} build_url:https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/G3VWaJIXQCmNLU97tp52RA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/a40dfb1680ebe386979d9ac556f270ea53c7895cc195e44c28e3f5bb6d367c5f5c0eb6969a0242dcd61f5877f274e1ce39c071d6b3f71e38224babe161a9d77e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bc6cb0317cac969a9de8717ea2cd33edfee6cf1a435797ad88c1d87acebb2ebf6d7abd2cf5f17a319bbdb4ccacc674c2c0fde189f8f9ba4b7578106d949ad776"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:08.483170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:08.483500) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1452688264.551543-691200264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 05:18:08.567913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 05:18:08.568240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 05:18:08.568535) ========= ========= Total master_lag: 0.22 =========