builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1452290484.75 results: success (0) buildid: 20160108113026 builduid: 745c7bc74d014f96ac0cace9e6c8b421 revision: ea01aa74be131267e98f034d115df035bd86cd9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.747007) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.747435) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.747774) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006468 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.773354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.773671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.793420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.793846) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.843646) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.843998) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.844404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:24.844740) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 14:01: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% 82.5M=0s 2016-01-08 14:01:25 (82.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:25.026220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:25.026541) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013760 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:25.077438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 14:01:25.077961) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea01aa74be131267e98f034d115df035bd86cd9d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea01aa74be131267e98f034d115df035bd86cd9d --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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 14:01:25,487 truncating revision to first 12 chars 2016-01-08 14:01:25,487 Setting DEBUG logging. 2016-01-08 14:01:25,487 attempt 1/10 2016-01-08 14:01:25,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea01aa74be13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 14:01:26,789 unpacking tar archive at: fx-team-ea01aa74be13/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 14:01:26.707932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:26.708293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:26.719221) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:26.719504) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 14:01:26.719935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-08 14:01:26.723517) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:27 INFO - MultiFileLogger online at 20160108 14:01:27 in /builds/slave/test-pgo 14:01:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:01:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:01:27 INFO - {'append_to_log': False, 14:01:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:01:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:01:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:01:27 INFO - 'branch': 'Fx-Team', 14:01:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:27 INFO - 'config_files': ('talos/linux_config.py',), 14:01:27 INFO - 'default_actions': ('clobber', 14:01:27 INFO - 'read-buildbot-config', 14:01:27 INFO - 'download-and-extract', 14:01:27 INFO - 'populate-webroot', 14:01:27 INFO - 'create-virtualenv', 14:01:27 INFO - 'install', 14:01:27 INFO - 'run-tests'), 14:01:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:27 INFO - 'download_minidump_stackwalk': True, 14:01:27 INFO - 'download_symbols': 'ondemand', 14:01:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:27 INFO - 'installer_path': 'installer.exe', 14:01:27 INFO - 'log_level': 'info', 14:01:27 INFO - 'log_name': 'talos', 14:01:27 INFO - 'log_to_console': True, 14:01:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:27 INFO - 'opt_config_files': (), 14:01:27 INFO - 'pip_index': False, 14:01:27 INFO - 'sps_profile': False, 14:01:27 INFO - 'sps_profile_interval': 0, 14:01:27 INFO - 'suite': 'dromaeojs', 14:01:27 INFO - 'system_bits': '32', 14:01:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:27 INFO - 'title': 'talos-linux64-ix-006', 14:01:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:27 INFO - 'use_talos_json': True, 14:01:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:01:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:27 INFO - 'work_dir': 'build'} 14:01:27 INFO - ##### 14:01:27 INFO - ##### Running clobber step. 14:01:27 INFO - ##### 14:01:27 INFO - Running pre-action listener: _resource_record_pre_action 14:01:27 INFO - Running main action method: clobber 14:01:27 INFO - rmtree: /builds/slave/test-pgo/build 14:01:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:01:27 INFO - Running post-action listener: _resource_record_post_action 14:01:27 INFO - ##### 14:01:27 INFO - ##### Running read-buildbot-config step. 14:01:27 INFO - ##### 14:01:27 INFO - Running pre-action listener: _resource_record_pre_action 14:01:27 INFO - Running main action method: read_buildbot_config 14:01:27 INFO - Using buildbot properties: 14:01:27 INFO - { 14:01:27 INFO - "project": "", 14:01:27 INFO - "product": "firefox", 14:01:27 INFO - "script_repo_revision": "production", 14:01:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:01:27 INFO - "repository": "", 14:01:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:01:27 INFO - "buildid": "20160108113026", 14:01:27 INFO - "pgo_build": "True", 14:01:27 INFO - "basedir": "/builds/slave/test-pgo", 14:01:27 INFO - "buildnumber": 883, 14:01:27 INFO - "slavename": "talos-linux64-ix-006", 14:01:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:01:27 INFO - "platform": "ubuntu64_hw", 14:01:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:01:27 INFO - "branch": "fx-team", 14:01:27 INFO - "repo_path": "integration/fx-team", 14:01:27 INFO - "revision": "ea01aa74be131267e98f034d115df035bd86cd9d", 14:01:27 INFO - "stage_platform": "linux64-pgo", 14:01:27 INFO - "builduid": "745c7bc74d014f96ac0cace9e6c8b421", 14:01:27 INFO - "slavebuilddir": "test" 14:01:27 INFO - } 14:01:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:01:27 INFO - Running post-action listener: _resource_record_post_action 14:01:27 INFO - ##### 14:01:27 INFO - ##### Running download-and-extract step. 14:01:27 INFO - ##### 14:01:27 INFO - Running pre-action listener: _resource_record_pre_action 14:01:27 INFO - Running main action method: download_and_extract 14:01:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:01: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')]} 14:01:27 INFO - https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/test_packages.json 14:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/test_packages.json 14:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:01:30 INFO - Downloaded 1302 bytes. 14:01:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:01:30 INFO - Using the following test package requirements: 14:01:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'jsshell-linux-x86_64.zip'], 14:01:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:01:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:01:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:30 INFO - https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:32 INFO - Downloaded 24024875 bytes. 14:01:32 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 14:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:32 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 14:01:33 INFO - Return code: 0 14:01:33 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 14:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:33 INFO - https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:36 INFO - Downloaded 24024875 bytes. 14:01:36 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 14:01:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:01:36 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 14:01:37 INFO - Return code: 0 14:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:38 INFO - https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:38 INFO - Downloaded 11132285 bytes. 14:01:38 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 14:01:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:38 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 14:01:39 INFO - Return code: 0 14:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:39 INFO - https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/atPdRc-tTDSCADuFIcF0iA/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 14:01:40 INFO - Downloaded 55801228 bytes. 14:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:01:40 INFO - mkdir: /builds/slave/test-pgo/properties 14:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:01:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:01:40 INFO - Contents: 14:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:01:40 INFO - Running post-action listener: _resource_record_post_action 14:01:40 INFO - Running post-action listener: set_extra_try_arguments 14:01:40 INFO - ##### 14:01:40 INFO - ##### Running populate-webroot step. 14:01:40 INFO - ##### 14:01:40 INFO - Running pre-action listener: _resource_record_pre_action 14:01:40 INFO - Running main action method: populate_webroot 14:01:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:40 INFO - '--tppagecycles', 14:01:40 INFO - '7'], 14:01:40 INFO - 'tests': ['tsvgm']}}, 14:01:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:01:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:01:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'tests': ['damp', 'tps']}, 14:01:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['damp', 'tps']}, 14:01:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:40 INFO - 'other': {'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'other_l64': {'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:40 INFO - 'ts_paint', 14:01:40 INFO - 'tpaint', 14:01:40 INFO - 'sessionrestore', 14:01:40 INFO - 'sessionrestore_no_auto_restore']}, 14:01:40 INFO - 'svgr': {'tests': ['tsvgx', 14:01:40 INFO - 'tsvgr_opacity', 14:01:40 INFO - 'tart', 14:01:40 INFO - 'tscrollx', 14:01:40 INFO - 'cart']}, 14:01:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['tsvgx', 14:01:40 INFO - 'tsvgr_opacity', 14:01:40 INFO - 'tart', 14:01:40 INFO - 'tscrollx', 14:01:40 INFO - 'cart']}, 14:01:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'tests': ['tp5o']}, 14:01:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'talos_options': ['--e10s'], 14:01:40 INFO - 'tests': ['tp5o']}, 14:01:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'talos_options': ['--xperf_path', 14:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:40 INFO - 'tests': ['tp5n']}, 14:01:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:40 INFO - 'talos_options': ['--e10s', 14:01:40 INFO - '--xperf_path', 14:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:40 INFO - 'tests': ['tp5n']}}, 14:01:40 INFO - 'talos.zip': {'path': '', 14:01:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:40 INFO - Running post-action listener: _resource_record_post_action 14:01:40 INFO - ##### 14:01:40 INFO - ##### Running create-virtualenv step. 14:01:40 INFO - ##### 14:01:40 INFO - Running pre-action listener: _resource_record_pre_action 14:01:40 INFO - Running main action method: create_virtualenv 14:01:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:01:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:01:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:01:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:40 INFO - Using real prefix '/usr' 14:01:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:01:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:43 INFO - Installing pip.................done. 14:01:43 INFO - Return code: 0 14:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:43 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 14:01:43 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 14:01:43 INFO - Using env: {'DISPLAY': ':0', 14:01:43 INFO - 'HOME': '/home/cltbld', 14:01:43 INFO - 'LANG': 'en_US.UTF-8', 14:01:43 INFO - 'LANGUAGE': 'en_US:en', 14:01:43 INFO - 'LOGNAME': 'cltbld', 14:01:43 INFO - 'MAIL': '/var/mail/cltbld', 14:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:43 INFO - 'MOZ_NO_REMOTE': '1', 14:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:43 INFO - 'NO_EM_RESTART': '1', 14:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:43 INFO - 'SHELL': '/bin/bash', 14:01:43 INFO - 'SHLVL': '1', 14:01:43 INFO - 'TERM': 'linux', 14:01:43 INFO - 'TMOUT': '86400', 14:01:43 INFO - 'USER': 'cltbld', 14:01:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:43 INFO - '_': '/tools/buildbot/bin/python'} 14:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:01:43 INFO - Cleaning up... 14:01:43 INFO - Return code: 0 14:01:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:43 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:43 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 14:01:43 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 14:01:43 INFO - Using env: {'DISPLAY': ':0', 14:01:43 INFO - 'HOME': '/home/cltbld', 14:01:43 INFO - 'LANG': 'en_US.UTF-8', 14:01:43 INFO - 'LANGUAGE': 'en_US:en', 14:01:43 INFO - 'LOGNAME': 'cltbld', 14:01:43 INFO - 'MAIL': '/var/mail/cltbld', 14:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:43 INFO - 'MOZ_NO_REMOTE': '1', 14:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:43 INFO - 'NO_EM_RESTART': '1', 14:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:43 INFO - 'SHELL': '/bin/bash', 14:01:43 INFO - 'SHLVL': '1', 14:01:43 INFO - 'TERM': 'linux', 14:01:43 INFO - 'TMOUT': '86400', 14:01:43 INFO - 'USER': 'cltbld', 14:01:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:43 INFO - '_': '/tools/buildbot/bin/python'} 14:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:43 INFO - Downloading/unpacking psutil>=0.7.1 14:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:45 INFO - Installing collected packages: psutil 14:01:45 INFO - Running setup.py install for psutil 14:01:45 INFO - building 'psutil._psutil_linux' extension 14:01:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:01:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:01:45 INFO - building 'psutil._psutil_posix' extension 14:01:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:01:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:46 INFO - Successfully installed psutil 14:01:46 INFO - Cleaning up... 14:01:46 INFO - Return code: 0 14:01:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:46 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:46 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 14:01:46 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 14:01:46 INFO - Using env: {'DISPLAY': ':0', 14:01:46 INFO - 'HOME': '/home/cltbld', 14:01:46 INFO - 'LANG': 'en_US.UTF-8', 14:01:46 INFO - 'LANGUAGE': 'en_US:en', 14:01:46 INFO - 'LOGNAME': 'cltbld', 14:01:46 INFO - 'MAIL': '/var/mail/cltbld', 14:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:46 INFO - 'MOZ_NO_REMOTE': '1', 14:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:46 INFO - 'NO_EM_RESTART': '1', 14:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:46 INFO - 'SHELL': '/bin/bash', 14:01:46 INFO - 'SHLVL': '1', 14:01:46 INFO - 'TERM': 'linux', 14:01:46 INFO - 'TMOUT': '86400', 14:01:46 INFO - 'USER': 'cltbld', 14:01:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:46 INFO - '_': '/tools/buildbot/bin/python'} 14:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:48 INFO - Installing collected packages: mozsystemmonitor 14:01:48 INFO - Running setup.py install for mozsystemmonitor 14:01:48 INFO - Successfully installed mozsystemmonitor 14:01:48 INFO - Cleaning up... 14:01:48 INFO - Return code: 0 14:01:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:48 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:48 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 14:01:48 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 14:01:48 INFO - Using env: {'DISPLAY': ':0', 14:01:48 INFO - 'HOME': '/home/cltbld', 14:01:48 INFO - 'LANG': 'en_US.UTF-8', 14:01:48 INFO - 'LANGUAGE': 'en_US:en', 14:01:48 INFO - 'LOGNAME': 'cltbld', 14:01:48 INFO - 'MAIL': '/var/mail/cltbld', 14:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:48 INFO - 'MOZ_NO_REMOTE': '1', 14:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:48 INFO - 'NO_EM_RESTART': '1', 14:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:48 INFO - 'SHELL': '/bin/bash', 14:01:48 INFO - 'SHLVL': '1', 14:01:48 INFO - 'TERM': 'linux', 14:01:48 INFO - 'TMOUT': '86400', 14:01:48 INFO - 'USER': 'cltbld', 14:01:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:48 INFO - '_': '/tools/buildbot/bin/python'} 14:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:01:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:50 INFO - Downloading docopt-0.6.1.tar.gz 14:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:50 INFO - Running setup.py install for blobuploader 14:01:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:01:50 INFO - Running setup.py install for requests 14:01:51 INFO - Running setup.py install for docopt 14:01:51 INFO - Successfully installed blobuploader requests docopt 14:01:51 INFO - Cleaning up... 14:01:51 INFO - Return code: 0 14:01:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:51 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:51 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 14:01:51 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 14:01:51 INFO - Using env: {'DISPLAY': ':0', 14:01:51 INFO - 'HOME': '/home/cltbld', 14:01:51 INFO - 'LANG': 'en_US.UTF-8', 14:01:51 INFO - 'LANGUAGE': 'en_US:en', 14:01:51 INFO - 'LOGNAME': 'cltbld', 14:01:51 INFO - 'MAIL': '/var/mail/cltbld', 14:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:51 INFO - 'MOZ_NO_REMOTE': '1', 14:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:51 INFO - 'NO_EM_RESTART': '1', 14:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:51 INFO - 'SHELL': '/bin/bash', 14:01:51 INFO - 'SHLVL': '1', 14:01:51 INFO - 'TERM': 'linux', 14:01:51 INFO - 'TMOUT': '86400', 14:01:51 INFO - 'USER': 'cltbld', 14:01:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:51 INFO - '_': '/tools/buildbot/bin/python'} 14:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:51 INFO - Running setup.py (path:/tmp/pip-1_tNld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:51 INFO - Running setup.py (path:/tmp/pip-H_biSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:51 INFO - Running setup.py (path:/tmp/pip-Y3pge5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:52 INFO - Running setup.py (path:/tmp/pip-IgbcAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:52 INFO - Running setup.py (path:/tmp/pip-EI_vBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:52 INFO - Running setup.py (path:/tmp/pip-Qkp_aN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:52 INFO - Running setup.py (path:/tmp/pip-TLzFeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:52 INFO - Running setup.py (path:/tmp/pip-uQy86O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:52 INFO - Running setup.py (path:/tmp/pip-QRJQnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:52 INFO - Running setup.py (path:/tmp/pip-id1_0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:52 INFO - Running setup.py (path:/tmp/pip-reKpuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:52 INFO - Running setup.py (path:/tmp/pip-igL6Nc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:52 INFO - Running setup.py (path:/tmp/pip-fH_OZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:52 INFO - Running setup.py (path:/tmp/pip-ZgmLNg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:52 INFO - Running setup.py (path:/tmp/pip-T9NzEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:52 INFO - Running setup.py (path:/tmp/pip-4VX8_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:52 INFO - Running setup.py (path:/tmp/pip-xW81Pf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:53 INFO - Running setup.py install for manifestparser 14:01:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Running setup.py install for mozcrash 14:01:53 INFO - Running setup.py install for mozdebug 14:01:53 INFO - Running setup.py install for mozdevice 14:01:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Running setup.py install for mozfile 14:01:53 INFO - Running setup.py install for mozhttpd 14:01:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Running setup.py install for mozinfo 14:01:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Running setup.py install for mozInstall 14:01:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:01:53 INFO - Running setup.py install for mozleak 14:01:53 INFO - Running setup.py install for mozlog 14:01:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Running setup.py install for moznetwork 14:01:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Running setup.py install for mozprocess 14:01:54 INFO - Running setup.py install for mozprofile 14:01:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Running setup.py install for mozrunner 14:01:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Running setup.py install for mozscreenshot 14:01:54 INFO - Running setup.py install for moztest 14:01:54 INFO - Running setup.py install for mozversion 14:01:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:01:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:54 INFO - Cleaning up... 14:01:54 INFO - Return code: 0 14:01:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:54 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:54 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 14:01:54 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 14:01:54 INFO - Using env: {'DISPLAY': ':0', 14:01:54 INFO - 'HOME': '/home/cltbld', 14:01:54 INFO - 'LANG': 'en_US.UTF-8', 14:01:54 INFO - 'LANGUAGE': 'en_US:en', 14:01:54 INFO - 'LOGNAME': 'cltbld', 14:01:54 INFO - 'MAIL': '/var/mail/cltbld', 14:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:54 INFO - 'MOZ_NO_REMOTE': '1', 14:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:54 INFO - 'NO_EM_RESTART': '1', 14:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:54 INFO - 'SHELL': '/bin/bash', 14:01:54 INFO - 'SHLVL': '1', 14:01:54 INFO - 'TERM': 'linux', 14:01:54 INFO - 'TMOUT': '86400', 14:01:54 INFO - 'USER': 'cltbld', 14:01:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:54 INFO - '_': '/tools/buildbot/bin/python'} 14:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:55 INFO - Running setup.py (path:/tmp/pip-ilsMSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:55 INFO - Running setup.py (path:/tmp/pip-9enrCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:55 INFO - Running setup.py (path:/tmp/pip-UTmSk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:55 INFO - Running setup.py (path:/tmp/pip-5AcZLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:55 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)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:55 INFO - Running setup.py (path:/tmp/pip-SjthjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:55 INFO - Running setup.py (path:/tmp/pip-m6KlSw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:55 INFO - Running setup.py (path:/tmp/pip-duWM13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:55 INFO - Running setup.py (path:/tmp/pip-kaJEKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:55 INFO - Running setup.py (path:/tmp/pip-nlbiSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:55 INFO - Running setup.py (path:/tmp/pip-Sxzc1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:55 INFO - Running setup.py (path:/tmp/pip-K3X3xm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:55 INFO - Running setup.py (path:/tmp/pip-To1xoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:55 INFO - Running setup.py (path:/tmp/pip-9anA5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:55 INFO - Running setup.py (path:/tmp/pip-nNpCwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:56 INFO - Running setup.py (path:/tmp/pip-YxbqRq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:56 INFO - Running setup.py (path:/tmp/pip-BA_7wU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:56 INFO - Running setup.py (path:/tmp/pip-OWHFUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:56 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)) 14:01:56 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)) 14:01:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:57 INFO - Downloading blessings-1.5.1.tar.gz 14:01:57 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 14:01:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:58 INFO - Installing collected packages: blessings 14:01:58 INFO - Running setup.py install for blessings 14:01:58 INFO - Successfully installed blessings 14:01:58 INFO - Cleaning up... 14:01:58 INFO - Return code: 0 14:01:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:01:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:58 INFO - Reading from file tmpfile_stdout 14:01:58 INFO - Current package versions: 14:01:58 INFO - argparse == 1.2.1 14:01:58 INFO - blessings == 1.5.1 14:01:58 INFO - blobuploader == 1.2.4 14:01:58 INFO - docopt == 0.6.1 14:01:58 INFO - manifestparser == 1.1 14:01:58 INFO - mozInstall == 1.12 14:01:58 INFO - mozcrash == 0.16 14:01:58 INFO - mozdebug == 0.1 14:01:58 INFO - mozdevice == 0.47 14:01:58 INFO - mozfile == 1.2 14:01:58 INFO - mozhttpd == 0.7 14:01:58 INFO - mozinfo == 0.9 14:01:58 INFO - mozleak == 0.1 14:01:58 INFO - mozlog == 3.1 14:01:58 INFO - moznetwork == 0.27 14:01:58 INFO - mozprocess == 0.22 14:01:58 INFO - mozprofile == 0.28 14:01:58 INFO - mozrunner == 6.11 14:01:58 INFO - mozscreenshot == 0.1 14:01:58 INFO - mozsystemmonitor == 0.0 14:01:58 INFO - moztest == 0.7 14:01:58 INFO - mozversion == 1.4 14:01:58 INFO - psutil == 3.1.1 14:01:58 INFO - requests == 1.2.3 14:01:58 INFO - wsgiref == 0.1.2 14:01:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:58 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:58 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 14:01:58 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 14:01:58 INFO - Using env: {'DISPLAY': ':0', 14:01:58 INFO - 'HOME': '/home/cltbld', 14:01:58 INFO - 'LANG': 'en_US.UTF-8', 14:01:58 INFO - 'LANGUAGE': 'en_US:en', 14:01:58 INFO - 'LOGNAME': 'cltbld', 14:01:58 INFO - 'MAIL': '/var/mail/cltbld', 14:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:58 INFO - 'MOZ_NO_REMOTE': '1', 14:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:58 INFO - 'NO_EM_RESTART': '1', 14:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:58 INFO - 'SHELL': '/bin/bash', 14:01:58 INFO - 'SHLVL': '1', 14:01:58 INFO - 'TERM': 'linux', 14:01:58 INFO - 'TMOUT': '86400', 14:01:58 INFO - 'USER': 'cltbld', 14:01:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:58 INFO - '_': '/tools/buildbot/bin/python'} 14:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:01:58 INFO - Cleaning up... 14:01:58 INFO - Return code: 0 14:01:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:58 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:58 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 14:01:58 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 14:01:58 INFO - Using env: {'DISPLAY': ':0', 14:01:58 INFO - 'HOME': '/home/cltbld', 14:01:58 INFO - 'LANG': 'en_US.UTF-8', 14:01:58 INFO - 'LANGUAGE': 'en_US:en', 14:01:58 INFO - 'LOGNAME': 'cltbld', 14:01:58 INFO - 'MAIL': '/var/mail/cltbld', 14:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:58 INFO - 'MOZ_NO_REMOTE': '1', 14:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:58 INFO - 'NO_EM_RESTART': '1', 14:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:58 INFO - 'SHELL': '/bin/bash', 14:01:58 INFO - 'SHLVL': '1', 14:01:58 INFO - 'TERM': 'linux', 14:01:58 INFO - 'TMOUT': '86400', 14:01:58 INFO - 'USER': 'cltbld', 14:01:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:58 INFO - '_': '/tools/buildbot/bin/python'} 14:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:58 INFO - Downloading/unpacking jsonschema 14:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:00 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 14:02:00 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:00 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:02:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:00 INFO - warning: no files found matching '*.txt' 14:02:00 INFO - no previously-included directories found matching 'build' 14:02:00 INFO - no previously-included directories found matching 'dist' 14:02:00 INFO - no previously-included directories found matching '.git*' 14:02:00 INFO - Installing collected packages: jsonschema, functools32 14:02:00 INFO - Running setup.py install for functools32 14:02:00 INFO - warning: no files found matching '*.txt' 14:02:00 INFO - no previously-included directories found matching 'build' 14:02:00 INFO - no previously-included directories found matching 'dist' 14:02:00 INFO - no previously-included directories found matching '.git*' 14:02:00 INFO - Successfully installed jsonschema functools32 14:02:00 INFO - Cleaning up... 14:02:01 INFO - Return code: 0 14:02:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 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 0x7ff74fdfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b12630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:01 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 14:02:01 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 14:02:01 INFO - Using env: {'DISPLAY': ':0', 14:02:01 INFO - 'HOME': '/home/cltbld', 14:02:01 INFO - 'LANG': 'en_US.UTF-8', 14:02:01 INFO - 'LANGUAGE': 'en_US:en', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MAIL': '/var/mail/cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SHLVL': '1', 14:02:01 INFO - 'TERM': 'linux', 14:02:01 INFO - 'TMOUT': '86400', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - '_': '/tools/buildbot/bin/python'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Downloading/unpacking flake8 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:02 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 14:02:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:03 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 14:02:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 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 14:02:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:03 INFO - no previously-included directories found matching 'docs/_build' 14:02:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:03 INFO - Running setup.py install for pep8 14:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:03 INFO - no previously-included directories found matching 'docs/_build' 14:02:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:02:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:03 INFO - Cleaning up... 14:02:03 INFO - Return code: 0 14:02:03 INFO - Running post-action listener: _resource_record_post_action 14:02:03 INFO - Running post-action listener: _start_resource_monitoring 14:02:03 INFO - Starting resource monitoring. 14:02:03 INFO - ##### 14:02:03 INFO - ##### Running install step. 14:02:03 INFO - ##### 14:02:03 INFO - Running pre-action listener: _resource_record_pre_action 14:02:03 INFO - Running main action method: install 14:02:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:02:04 INFO - Reading from file tmpfile_stdout 14:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:02:04 INFO - Reading from file tmpfile_stdout 14:02:04 INFO - Output received: 14:02:04 INFO - Usage: mozinstall [options] installer 14:02:04 INFO - Options: 14:02:04 INFO - -h, --help show this help message and exit 14:02:04 INFO - -d DEST, --destination=DEST 14:02:04 INFO - Directory to install application into. [default: 14:02:04 INFO - "/builds/slave/test-pgo"] 14:02:04 INFO - --app=APP Application being installed. [default: firefox] 14:02:04 INFO - mkdir: /builds/slave/test-pgo/build/application 14:02:04 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'] 14:02:04 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 14:02:20 INFO - Reading from file tmpfile_stdout 14:02:20 INFO - Output received: 14:02:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:02:20 INFO - Running post-action listener: _resource_record_post_action 14:02:20 INFO - ##### 14:02:20 INFO - ##### Running run-tests step. 14:02:20 INFO - ##### 14:02:20 INFO - Running pre-action listener: _resource_record_pre_action 14:02:20 INFO - Running main action method: run_tests 14:02:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:02:20 INFO - Python 2.7.3 14:02:20 INFO - Return code: 0 14:02:20 INFO - grabbing minidump binary from tooltool 14:02: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')]} 14:02:20 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 0x2ba3840>, '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 0x2b106b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b10b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:02:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:02:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:02:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:20 INFO - Return code: 0 14:02:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:02:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:02:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:02:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:02:21 INFO - Return code: 0 14:02:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:02:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:02:21 INFO - Using env: {'DISPLAY': ':0', 14:02:21 INFO - 'HOME': '/home/cltbld', 14:02:21 INFO - 'LANG': 'en_US.UTF-8', 14:02:21 INFO - 'LANGUAGE': 'en_US:en', 14:02:21 INFO - 'LOGNAME': 'cltbld', 14:02:21 INFO - 'MAIL': '/var/mail/cltbld', 14:02:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:02:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:21 INFO - 'MOZ_NO_REMOTE': '1', 14:02:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:21 INFO - 'NO_EM_RESTART': '1', 14:02:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:02:21 INFO - 'SHELL': '/bin/bash', 14:02:21 INFO - 'SHLVL': '1', 14:02:21 INFO - 'TERM': 'linux', 14:02:21 INFO - 'TMOUT': '86400', 14:02:21 INFO - 'USER': 'cltbld', 14:02:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651', 14:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:21 INFO - '_': '/tools/buildbot/bin/python'} 14:02:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:02:21 INFO - mozversion application_buildid: 20160108113026 14:02:21 INFO - mozversion application_changeset: ea01aa74be131267e98f034d115df035bd86cd9d 14:02:21 INFO - mozversion application_display_name: Nightly 14:02:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:21 INFO - mozversion application_name: Firefox 14:02:21 INFO - mozversion application_remotingname: firefox 14:02:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:02:21 INFO - mozversion application_vendor: Mozilla 14:02:21 INFO - mozversion application_version: 46.0a1 14:02:21 INFO - mozversion platform_buildid: 20160108113026 14:02:21 INFO - mozversion platform_changeset: ea01aa74be131267e98f034d115df035bd86cd9d 14:02:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:02:21 INFO - mozversion platform_version: 46.0a1 14:02:21 INFO - using testdate: 1452290541 14:02:21 INFO - actual date: 1452290541 14:02:21 INFO - starting webserver on 'localhost:56814' 14:02:21 INFO - SUITE-START | Running 3 tests 14:02:21 INFO - TEST-START | dromaeo_css 14:02:21 INFO - operating with platform_type : linux_ 14:02:21 INFO - Initialising browser for dromaeo_css test... 14:02:21 INFO - TEST-INFO | started process 19301 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDjPwLI/profile http://localhost:56814/getInfo.html) 14:02:25 INFO - PROCESS | 19301 | __metrics Screen width/height:1600/1200 14:02:25 INFO - PROCESS | 19301 | colorDepth:24 14:02:25 INFO - PROCESS | 19301 | Browser inner width/height: 1024/697 14:02:25 INFO - PROCESS | 19301 | __metrics 14:02:25 INFO - PROCESS | 19301 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:02:25 INFO - PROCESS | 19301 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:26 INFO - TEST-INFO | 19301: exit 0 14:02:26 INFO - Browser initialized. 14:02:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:02:26 INFO - TEST-INFO | started process 19400 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDjPwLI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:38 INFO - PROCESS | 19400 | RSS: Main: 148086784 14:02:38 INFO - PROCESS | 19400 | 14:03:29 INFO - PROCESS | 19400 | 1452290609698 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:05:37 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56814/tests/dromaeo/cssquery-ext.html) 14:05:38 INFO - PROCESS | 19400 | RSS: Main: 273747968 14:05:38 INFO - PROCESS | 19400 | 14:08:41 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-ext.html (next: http://localhost:56814/tests/dromaeo/cssquery-jquery.html) 14:08:41 INFO - PROCESS | 19400 | RSS: Main: 240472064 14:08:41 INFO - PROCESS | 19400 | 14:11:43 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56814/tests/dromaeo/cssquery-mootools.html) 14:11:44 INFO - PROCESS | 19400 | RSS: Main: 237981696 14:11:44 INFO - PROCESS | 19400 | 14:14:46 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56814/tests/dromaeo/cssquery-prototype.html) 14:14:46 INFO - PROCESS | 19400 | RSS: Main: 214654976 14:14:46 INFO - PROCESS | 19400 | 14:17:49 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56814/tests/dromaeo/cssquery-yui.html) 14:17:50 INFO - PROCESS | 19400 | RSS: Main: 219066368 14:17:50 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-yui.html (next: http://localhost:56814/tests/dromaeo/cssquery-dojo.html) 14:20:52 INFO - PROCESS | 19400 | RSS: Main: 267259904 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | __start_tp_report 14:20:52 INFO - PROCESS | 19400 | _x_x_mozilla_page_load 14:20:52 INFO - PROCESS | 19400 | _x_x_mozilla_page_load_details 14:20:52 INFO - PROCESS | 19400 | |i|pagename|runs| 14:20:52 INFO - PROCESS | 19400 | |0;dojo.html;3108.8756449742014;3162.826044567548;3162.9999999999986;3183.060997005883;3202.2474718441163;4985.601151907847;5095.745212739367;5129.512696293856;5139.820106296275;5182.559482443992;5059.266406371084;5151.871203219921;5196.272521846944;5228.973855130719;5230.6600070995355;4521.276595744682;4598.241290187124;4629.814807407716;4647.9535204647855;4821.4696383397795;4690.882727931795;4748.311494833247;4760.880977975544;4800.1119792838435;4860;4639.744814035227;4694.201985662446;4695.506971767949;4734.100520901018;4755.405574303212;4666.23007203811;4693.507181745936;4693.741844198567;4718.740469274188;4721.551452611996;4643.955110100234;4669.159551280768;4681.133990211822;4703.905921881543;4753.239481682914;5002.774875130628;5096.566791822699;5097.0315640028275;5113.2330150477355;5113.53978141969;5569.526590239834;5604.2714447122025;5612.214289999403;5614.831555053355;5617.893737291359;5504.339479262514;5554.750036248379;5606.187102870061;5639.605227634026;5677.403872593401;5224.08578498765;5243.056249875059;5246.97376513115;5255.658382205144;5258;5691;5723.084306510938;5725.312962444534;5728.083506639001;5728.283964504437;5388.784448622089;5455.345358556999;5483.232347471358;5539.14143307788;5540.750666219949;5574.470425309589;5624.91562626561;5632.5775566831835;5633.492985631231;5634.802781902696;5546.694931778791;5601.943980560142;5606.046972014768;5610.32676078865;5613.129964855454;5368.32895888014;5488.588355873326;5557.499825015768;5566.081596536526;5599.664020158803;4332.956670433256;4333.826646934087;4347.6304514116655;4371.693981421334;4373.518912919576;3850.306944749916;3861.8841434757;3874.8450061997205;3917.0794863207125;3917.2948869203815;5014.6991180529285;5130.127878260705;5179.948200518022;5187.221916712523;5205.167173252262;5470.5350045245805;5472.5621950243885;5476.644018138808;5487.6158668893595;5523.558115350762;5116.820911268088;5130.384353877558;5132;5136.691798492103;5177;4532.184206842734;4612.3542704021465;4690;4719;4780.904381912412;5748.252727145528;5750.1949727038245;5760.913586296209;5775.393583673654;5790.102534107136;5521.558275337883;5534.308211473566;5534.889302214014;5538.529225015919;5549.916751248816;5536.52939500147;5635.549156067586;5727.39862314451;5743.253377060955;5743.59794814359;5415.512603865671;5419.105847535113;5426.484483974016;5427.13165893471;5456.236126942311;5469.15228139639;5470.72646367672;5476.041692703681;5494.532964697885;5529.391766905717;5251.36983561975;5351.2508248844415;5405.405405405324;5436.918446223389;5574.498295153456;5335.199720042025;5343.919841202307;5363.115086010765;5377.946220537745;5383.273258110262;5279.39286982002;5282.762275697526;5288.365396152486;5299.284596579567;5334.67991920486;5321.600879933943;5391.137418013099;5408.5673146149;5449.809256676156;5507.421720719427;5229.712365819916;5230.712310822942;5231.973840130775;5244.213367994678;5302.867428314323 14:20:52 INFO - PROCESS | 19400 | |1;ext.html;524.7087866234239;530.8832056947472;543.5651478816945;562.0585519255246;566.3402136510965;27936.860315698417;28561;35624.64375356246;36438.271234575295;36455.4531682025;38521.61478385215;38630;38718.80640596793;38903.80548097256;38927;8342.624581893799;8508.702195423162;8537.658493660247;8540.316774658044;8540.615672294762;8352.12302708216;8459.492430454193;8462.069172391031;8473.322134229278;8488.066312705598;8381.45520541166;8533.402661813676;8724.8691269631;8733.7816554586;8737.825243495126;8558.657653693845;8587.270082043035;8593.914060859373;8672.436291641086;8674.739757807245;8464.534450605213;8588.656453741844;8607.569621518898;8609.440386374928;8619.1811777881;38985;39257.214855702725;39385;39498.80250598757;39528.20943581112;3138.107659237021;3184.6656101109284;3306.2230375861895;3373.713234375081;3440.70753985909;28078.438431231465;30286.69713302883;30387.544186837215;30455;30716.846415768003;3842.4620553122304;4046.0491784430637;4064.8374065037365;4077.7145599808027;4154.937675934863;263752;264403.9999999981;264576;265659;265665;51083;51699.483005170216;52003.219951700754;52079.73960130175;52148.21777673338;47888.760556197;62657.373426266066;63800.36199637944;63868.68065659642;63915.36084639094;14740.262986850614;15172.468963586221;15181.62045948838;15188.848111518964;15210.847891520943;9962.551685174185;10047.24645651579;10591.152707783358;10605.25763196569;11033.668989930315;18753;18947.715784263248;19060.332888348843;19112.426627201206;19137.521561960784;7020.5787652741;7210.242924492957;7338;7365.337119659256;7418.332350088518;943.6366998705548;974.6247694637474;1042.2339580408393;1053.2785042246087;1069.7539565899888;26478.86760566185;28095.71904280972;28212.576811347848;28247.57628635572;28459.28851778681;1016.1819735113305;1065.0840277361463;1076.956921723138;1117.664700589836;1198.1553005131361;14564.708705826037;14646.439443085812;14693.632659183391;14961.551153465414;15007.424220456694;314871;318182;318805;319425;320053;49001.50998490041;49532;49618.75190624096;49754.25368619474;49870.501294986585;1291.5802364231663;1293.4050336844969;1310.7640624687647;1316.374722007039;1319.7162610038888;27117.457650847267;28056.71943280541;28153.296167595974;28953.420931581673;30814.845925770227;48508;49874;50150.24774628456;50184.74907625438;50204;245186;246883;247350;247524;247921;27296;31044.689553105083;31484;31517.684823151474;31947.68052319447;36819.63180368162;37193.44209836909;37266.441003384425;37943.81028094842;38046.429303561024;29962.70037299599;32015.039548813573;34061.97814065582;36076.81961590175;36335.81832090823;31793;32279.193020174684;32337.19157020999;32570.83714581412;32658.673413265562;32179.51730723994;32483.35033299368;32678.183045423102;32767.672323276463;32767.836160819043;29271;31002.224944376572;31498.842505787325;31513.684863151993;31557.211069723442;24048.51902961966;24092.277231683078;24092.277231683078;24298.878505607358;24353.878230609444 14:20:52 INFO - PROCESS | 19400 | |2;jquery.html;356.12215887836476;356.5632100676671;357.67272945255087;357.967782899539;359.88843458527856;13555.52555660552;14109.788353174685;15861.68276634468;15991;16613.750793738105;14719.705605887875;15433.382664693427;15904.84095159048;15956;15963.84036159638;5032.54707076364;5180.1970694542215;5214.348206474191;5223.582113430916;5229.137192363274;3900.824462899162;4056.229316429869;5132.409772876111;5234.26720259164;5505.366882808468;5810.605197032243;5821.097729851858;5879.412058794108;5887.88224235515;5890.293164820207;5714.114312281603;5896;5903.822885313448;5907.5864689471755;5914.674692891889;5141.30592370029;5203.713795741232;5205.609579281569;5366.034113859504;5377.327834020747;19139.521511962314;19411.126499307564;19921.701174482394;20521.281755138647;20550;2024.9392518224477;2192.0683709423593;2230.542738738555;2354.058376649337;2385.8329916905823;12509.874901250962;12669.936650316782;12893.935530322382;12983.545575904798;13341.066125371228;1824.5894673698444;1863.5527473406285;1864.729614205946;1887.4620733091003;1893.640208360407;53811.46188538104;57018.714906425615;57355.42644573543;58037.075036607086;58916.70541647264;9461.290403219786;9565.282603804742;9832.803343933225;9833.360831545926;9894.752631184278;12808.231506109663;12834.743305133845;12910.870891291155;12912.741745165044;12913.09608327408;7471.066116735408;7491.213422590658;7606.619669016527;7650.2349765023055;7657.310842024244;7444.962775186089;7472.589007604525;7476.140243871915;7554.697812087565;7556.962215188999;5874.148248503943;5875.941240587539;5905.881882362414;5932.169496270526;5935.139404786281;1653.3138747419687;1702.378631799409;1733.930642774275;1765.2497688482345;1794.9910250448663;412.79979210083684;436.9279068953651;444.1095603315332;451.82830524400515;989.5744829723288;9370.437773733598;9687.321887467951;9874.308798384043;10035;10571.15430765537;431.5662758927258;451.7989494674838;460.3922821875093;894.1639567004742;958.1089586684311;8473.872891906627;8591.3556483264;8721.825563488695;8786.692465763668;8804;148059;148270.25864870608;149426;149941;150073;69325.3067469329;69552;71076.289237108;72901.27098729051;73666.26333736701;1144.5879483385975;1148.6209550848366;1157.3345326437332;1162.5001249462644;1166.8658104317942;13222.801657974946;13431.328433578477;13638.181709097486;13673.863261367656;13706.314684265946;30339.117783810503;30857;30871.382572348877;30994.380112397175;31588.842055789573;43744.78127609342;43772;43908;44254.77872610616;45494.317585235585;6994;7265.600391978492;7327.74352897646;7384.040074790243;7437.665305061393;10281.383117013003;10654.680359589225;10924.2899211551;11027.345898115347;11078.113750899747;3118.875244990266;5475.151351540518;8881.245094167069;9442.763930901783;9918.156956658477;7883.566403847614;9113.681021164228;9437.867455905336;9801.607935682778;10363.740906477398;3225.580674512298;3226.790258633181;7920.663404295631;9016.323775716717;9291.2102471288;6984.40632546219;7036.437085033082;7183.568985860865;7185.712571497082;7327.35134594712;9225.953870230605;9272.211861991806;9294.209992150472;9502.097300756417;9527.666531671359 14:20:52 INFO - PROCESS | 19400 | |3;mootools.html;1306.5361796562215;1435.676972681147;1446.5660301909427;1578.4475433598243;1754.9473515794523;6903.3096690331;7511.586862722548;7645.694172233104;7678.232176782319;7687.500312479685;7683.9231607683905;7869.409794265424;7876.291133797957;7878.094019187795;7885.172056934025;2030.3908827351809;2085.8435617328687;2218.8557743746646;2299.586074506588;2341.7775311345395;2340.9882950585225;2352.1767381416453;2352.999975010622;2353.0940587873706;2353.235198560466;2235;2269.9558203226534;2285.4743409015937;2289.072925465181;2301.8158547316257;2178.3356076396694;2192.210804110519;2333.7666233376694;2334.579775640384;2337.357226762637;2265.784750448705;2299.1608063057033;2305.13557415969;2310.6649535817214;2340.5552944940578;8020.959895200545;8051.154628763954;8079.394045446556;8080.39397045224;8089.393295502802;4653.650976176767;4756.405449318835;4762.880927976794;4767.046590681877;4768.094062128219;3123.9531407028912;3166.746660267173;3211.8715251389917;3222.4682927316962;3251.6748325167296;987.6395115782759;1002.9949850250702;1023.800358930009;1037.3827572594294;1038.9688309350731;10814.891851081546;10881.292715973437;10887.401192934385;10908.072813810835;10916.727081822939;4174.08170202555;4244.893877653021;4313.9137217255475;4319.956800431955;4323.286657701507;9303.627854885865;9316.301277404222;9333.626654933862;9341.906580934103;9351.345405821527;4816.590589799906;4820.590249828733;4855.223164293767;4857.319975203474;4865.148598995162;4408.603225709701;4412.977935110304;4421.336799480104;4424.181526417623;4426.955730442719;3390.4405773047665;3458.412069948115;3647.2310929199316;3677.3932301170544;3690.7231957603285;1196.6948428150765;1198.9700257493632;1205.2708111592535;1209.8608660004213;1218.945147468366;1321.4119716725966;1327.588447581253;1346.3402932562974;1347.5485712286493;1362.4073528015344;7131.607761573163;7245.818854528574;7268.563886166847;7273.16358618755;7275.4179665626625;1109.4896347680158;1112.3826276416667;1112.5660992213043;1113.7382715061954;1144.8969592736694;5871.471567558855;5929.6145750526075;5931.347551769302;5931.911021334683;5932.58471906971;9306.581203845843;9398.530073496298;9495.097965693249;9550.808983820285;9551.617935282511;9453.810923781486;9503.097205765442;9529.285303602257;9530.90469095314;9531.904680953241;7210.71157153708;7421.666025028887;7510.474266801271;7518.962405188048;7527.473076884566;7233.3851622612665;7331.890021649786;7333.779986600411;7337.963310183415;7343.596102214429;8262.669493220445;8378.287845533197;8491.5329656867;8665.220130188314;8676.869846952428;8297.751067467985;8637.093105223861;8649.264812490757;8706.521141337287;8721.956390218009;6235.251769787473;6782.8643427132165;6907.723691052302;6926.238113807578;6931.965340173267;6997.755078572225;7307.9634601828775;7526.360259377795;7542.2834830691;7551.811204719926;6937.82655433598;7070.222275549582;7107.964460177873;7121.501494895515;7227.9638601806655;6859.691313890987;6908.378245957888;7002.474814388839;7085.185203701641;7100.0414943981905;6954.9304506956305;7002.159740831133;7036.050133231948;7041.155061392461;7155.356017958408;6574.76988305407;6611.504137189634;6614.570052946543;6618.139641846529;6638.800835974928;6662.367075127855;6686.866262674622;6732.3267673232285;6736.629485378351;6740.8651826962205 14:20:52 INFO - PROCESS | 19400 | |4;prototype.html;341.4093618040789;345.8858576669699;347.1529468097841;349.02273633825286;351.6562113513433;5761.9135712964335;5798.768049278035;5876.676782776951;5884.205632239647;5918.970405147974;5646.2942132233475;5839.620424672404;5850.707464626762;5865;5880.735366908489;4517.887052823689;4543.227651299287;4545.204589196894;4557.065801510699;4560.361549383089;4389.4513185851765;4410.75740834254;4416.381706561084;4494.550544945512;4549.658775591827;4457.9331310030375;4476.843310484133;4482.439695038121;4487.237169681162;4514.661400394967;4490.787487378406;4508.6618503612035;4522.751248681321;4523.751193684346;4530.59224669778;3995.1610161866042;3996.9400458993136;4000.9199816003807;4002.459667944848;4010.438538604598;5433.212184233304;5544.833654990316;5558.805441809517;5639.436056394369;5643.435656434365;5312.362516498045;5320.494553017457;5322.946770532284;5323.254744335757;5326.786928522854;5929.525637948954;6254.906176407358;6255.718492667841;6258.06129080637;6267.091271765568;4323.567643235683;4365.519792822787;4450.643948484114;4453.910921781546;4463.308187230952;6380.457661098812;6436.259830119549;6475.838104047437;6476.773312934025;6484.578502397329;4576.908461830745;4580.198465268565;4581.473130590025;4583;4594.47163576193;4545.38637283969;4623.606993405599;4626.352310676508;4635.304704294383;4645.628349732014;5227.581793456515;5273.446288139767;5277.709725965032;5279.313689220377;5283.762230699551;6244.46922011625;6247.96876015617;6249.0938813871735;6254.405831446005;6261.530385221126;1623.8294979027269;1647.2916645842404;1648.983510164907;1649.6783127290064;1650.6946214950271;1124.3872089711126;1131.575659127827;1131.7340425000118;1134.9886501135047;1156.115571587736;5924.644521328734;5927.822165334961;5937.970310148422;5939.910901336483;5940.70296485174;6398.2641996170105;6402.135711678957;6409.935900641027;6412.871742565123;6414.102025716404;5832.88334233313;5932.822015339547;5935.050391937356;5936.614120082181;5937.139114828326;3409.9488507672404;3456.274182421669;3461.2558299965626;3463.8268086595567;3464.4283693190846;6629.602223866584;6633.701483433257;6633.872241718919;6637.269900310962;6642.4021838034805;6513.739450422025;6530.379613936669;6535.44448721864;6538.084668146464;6543.280239173687;6487.091807147003;6633.635150066792;6634.933650663528;6635.966820165965;6642.568233064932;6215.223097112861;6349.650769207553;6378.362163783585;6380.457661098859;6388;6234.625922444668;6234.937650623436;6280.466160376419;6310.558260921692;6399.232092148972;6635.6350400728425;6649.069130321662;6649.46804255668;6662.233843108104;6664.766733164316;4521.638268938543;4566.4748553916725;4598.3792188054185;4599.448066232074;4603;6470.22357317125;6473.870522589427;6476.352364763486;6487.253965793805;6489.1888513935755;6285.340039295808;6310.558260921875;6312.747490100344;6321.52588555851;6321.905171422524;6183;6287.74849006053;6290.150829637941;6300.684965751602;6301.212348456443;6142.140100386039;6166.383361663977;6190.2571691397325;6191.25704915413;6203.100550420254;6321.462675672436;6332.30344662096;6333.36666333363;6340.541675414588;6340.556161068681;6087.117367981707;6180.165677633462;6185.567010309415;6189.04069869171;6192.164057852132 14:20:52 INFO - PROCESS | 19400 | |5;yui.html;693.5838496901858;831.5925196653642;832.2676045080328;834.557684427253;835.5446281776432;13313.8002929956;13326.600201993955;13352.198868067922;13427.731445371086;13442.731145377098;12636.93681531591;12655.683607909807;12699.619011429671;14333.641658958506;14558.417663293481;778.3656320099116;794.0074906367041;795.6300320351036;795.7214974758846;795.7493389582263;640.8878446271907;652.2043107408978;784.0434669702953;796.749024057423;800.4436916343144;827.9917200827974;829.8215883585028;833.7165363776314;834.7954751085992;836.3601844588894;671.3454381977582;827.9047909490396;828.035338830262;828.349745449819;828.353883970504;499.932509111269;595.9344472108108;608.069653430248;608.6895683201554;608.8843119807267;13684.65788355289;13719.794203086962;13789;13793.931030344884;13831.723365532735;11932.22440541362;12145.514179432812;12290.75418491634;12297.385130743427;12672.366381680971;9935.304528682995;10484.108850747696;10536.947315263375;10561.838197798235;10567;3695.371786796251;3731.440283957401;3737.2338670572467;3747.775133491972;3765.152840610868;46463.76768116171;46819.76590117062;47270.76364618189;47285.763571182266;48204.27693584599;10354.11989980845;10362.533685984148;10365.63720269787;10399.27205095636;10529.105026072717;18178;18281.908590457228;18327.90836045838;18335.90832045858;18404.447866564024;7797.961010194913;7944.165862584346;7981.48120372174;8039.276465118168;8045.07481639619;3955.0705584187695;4029.4157347185082;4068.898277543085;4070.3487442009136;4093.7339072960162;2883.480973424762;2909.956350654742;2913.548399998004;2915.4169166166853;2919.693432189632;533.2294833964884;534.7513406266105;546.9535089517356;548.2954403591366;572.3046498504337;529.4123522889589;573.6529399713197;626.8808926303988;634.096412612026;682.4097155960158;8945.46327220369;8979.685711000084;9067.35364768015;9099.636014559475;9209.764211422607;554.4206304411899;653.3858173317067;657.4471782903375;665.7403612591094;673.9730410783612;4219.367094935784;4244.3209086546;4246.40550322955;4375.190589740908;4393.868183954486;57655.81097701227;59282.11076833851;59440;59771.402285977456;59788.10317845236;46887;47978.760106199945;48257.75871120622;48406.51593484091;48758.26862597064;43094.35358469688;44299.11401771947;44531.55468445339;45848.54151458509;46081.76959115183;8643.265322447662;8751.562421879007;8877.689280875138;9130.634774608941;9399.85900211511;32607;33255;33298.667013329556;33410.33179336448;36138.819305904355;42437.5756242446;42580.36129458123;43395.783021084695;43712.12575748531;43923.78038109789;10850.782984340427;11138.721531961442;11176.441177941233;11252.83120753173;11376.08991280679;11717.00405465545;11981.161318707607;12061.51753929868;12314.13801033919;12450.937745311216;11277.436128193722;11687.76624467523;11708.47311870985;12121.757564848478;12312.81530777057;10868.836967445337;11132.387718675227;11311.264767790068;11477.942610286895;11913.046956243654;8280.951215980613;11554.711132221426;11883.405829708652;11965.820512692142;12251.816222756488;9490.952545237229;9636;9782.217422606032;9961;9998.550065246936;10138.23963202748;10155.644552440925;10192.490375481344;10510.264281500222;10511.159107271553 14:20:52 INFO - PROCESS | 19400 | __end_tp_report 14:20:52 INFO - PROCESS | 19400 | __start_cc_report 14:20:52 INFO - PROCESS | 19400 | _x_x_mozilla_cycle_collect,1031 14:20:52 INFO - PROCESS | 19400 | __end_cc_report 14:20:52 INFO - PROCESS | 19400 | __startTimestamp1452291652753__endTimestamp 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | ------- Summary: start ------- 14:20:52 INFO - PROCESS | 19400 | Number of tests: 6 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#0] dojo.html Cycles:165 Average:5142.63 Median:5288.37 stddev:558.70 (10.6%) stddev-sans-first:537.16 14:20:52 INFO - PROCESS | 19400 | Values: 3108.9 3162.8 3163.0 3183.1 3202.2 4985.6 5095.7 5129.5 5139.8 5182.6 5059.3 5151.9 5196.3 5229.0 5230.7 4521.3 4598.2 4629.8 4648.0 4821.5 4690.9 4748.3 4760.9 4800.1 4860.0 4639.7 4694.2 4695.5 4734.1 4755.4 4666.2 4693.5 4693.7 4718.7 4721.6 4644.0 4669.2 4681.1 4703.9 4753.2 5002.8 5096.6 5097.0 5113.2 5113.5 5569.5 5604.3 5612.2 5614.8 5617.9 5504.3 5554.8 5606.2 5639.6 5677.4 5224.1 5243.1 5247.0 5255.7 5258.0 5691.0 5723.1 5725.3 5728.1 5728.3 5388.8 5455.3 5483.2 5539.1 5540.8 5574.5 5624.9 5632.6 5633.5 5634.8 5546.7 5601.9 5606.0 5610.3 5613.1 5368.3 5488.6 5557.5 5566.1 5599.7 4333.0 4333.8 4347.6 4371.7 4373.5 3850.3 3861.9 3874.8 3917.1 3917.3 5014.7 5130.1 5179.9 5187.2 5205.2 5470.5 5472.6 5476.6 5487.6 5523.6 5116.8 5130.4 5132.0 5136.7 5177.0 4532.2 4612.4 4690.0 4719.0 4780.9 5748.3 5750.2 5760.9 5775.4 5790.1 5521.6 5534.3 5534.9 5538.5 5549.9 5536.5 5635.5 5727.4 5743.3 5743.6 5415.5 5419.1 5426.5 5427.1 5456.2 5469.2 5470.7 5476.0 5494.5 5529.4 5251.4 5351.3 5405.4 5436.9 5574.5 5335.2 5343.9 5363.1 5377.9 5383.3 5279.4 5282.8 5288.4 5299.3 5334.7 5321.6 5391.1 5408.6 5449.8 5507.4 5229.7 5230.7 5232.0 5244.2 5302.9 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#1] ext.html Cycles:180 Average:43935.84 Median:32722.93 stddev:72734.22 (222.3%) stddev-sans-first:72865.23 14:20:52 INFO - PROCESS | 19400 | Values: 524.7 530.9 543.6 562.1 566.3 27936.9 28561.0 35624.6 36438.3 36455.5 38521.6 38630.0 38718.8 38903.8 38927.0 8342.6 8508.7 8537.7 8540.3 8540.6 8352.1 8459.5 8462.1 8473.3 8488.1 8381.5 8533.4 8724.9 8733.8 8737.8 8558.7 8587.3 8593.9 8672.4 8674.7 8464.5 8588.7 8607.6 8609.4 8619.2 38985.0 39257.2 39385.0 39498.8 39528.2 3138.1 3184.7 3306.2 3373.7 3440.7 28078.4 30286.7 30387.5 30455.0 30716.8 3842.5 4046.0 4064.8 4077.7 4154.9 263752.0 264404.0 264576.0 265659.0 265665.0 51083.0 51699.5 52003.2 52079.7 52148.2 47888.8 62657.4 63800.4 63868.7 63915.4 14740.3 15172.5 15181.6 15188.8 15210.8 9962.6 10047.2 10591.2 10605.3 11033.7 18753.0 18947.7 19060.3 19112.4 19137.5 7020.6 7210.2 7338.0 7365.3 7418.3 943.6 974.6 1042.2 1053.3 1069.8 26478.9 28095.7 28212.6 28247.6 28459.3 1016.2 1065.1 1077.0 1117.7 1198.2 14564.7 14646.4 14693.6 14961.6 15007.4 314871.0 318182.0 318805.0 319425.0 320053.0 49001.5 49532.0 49618.8 49754.3 49870.5 1291.6 1293.4 1310.8 1316.4 1319.7 27117.5 28056.7 28153.3 28953.4 30814.8 48508.0 49874.0 50150.2 50184.7 50204.0 245186.0 246883.0 247350.0 247524.0 247921.0 27296.0 31044.7 31484.0 31517.7 31947.7 36819.6 37193.4 37266.4 37943.8 38046.4 29962.7 32015.0 34062.0 36076.8 36335.8 31793.0 32279.2 32337.2 32570.8 32658.7 32179.5 32483.4 32678.2 32767.7 32767.8 29271.0 31002.2 31498.8 31513.7 31557.2 24048.5 24092.3 24092.3 24298.9 24353.9 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#2] jquery.html Cycles:180 Average:16256.10 Median:5082.48 stddev:27188.11 (534.9%) stddev-sans-first:27238.17 14:20:52 INFO - PROCESS | 19400 | Values: 356.1 356.6 357.7 358.0 359.9 13555.5 14109.8 15861.7 15991.0 16613.8 14719.7 15433.4 15904.8 15956.0 15963.8 5032.5 5180.2 5214.3 5223.6 5229.1 3900.8 4056.2 5132.4 5234.3 5505.4 5810.6 5821.1 5879.4 5887.9 5890.3 5714.1 5896.0 5903.8 5907.6 5914.7 5141.3 5203.7 5205.6 5366.0 5377.3 19139.5 19411.1 19921.7 20521.3 20550.0 2024.9 2192.1 2230.5 2354.1 2385.8 12509.9 12669.9 12893.9 12983.5 13341.1 1824.6 1863.6 1864.7 1887.5 1893.6 53811.5 57018.7 57355.4 58037.1 58916.7 9461.3 9565.3 9832.8 9833.4 9894.8 12808.2 12834.7 12910.9 12912.7 12913.1 7471.1 7491.2 7606.6 7650.2 7657.3 7445.0 7472.6 7476.1 7554.7 7557.0 5874.1 5875.9 5905.9 5932.2 5935.1 1653.3 1702.4 1733.9 1765.2 1795.0 412.8 436.9 444.1 451.8 989.6 9370.4 9687.3 9874.3 10035.0 10571.2 431.6 451.8 460.4 894.2 958.1 8473.9 8591.4 8721.8 8786.7 8804.0 148059.0 148270.3 149426.0 149941.0 150073.0 69325.3 69552.0 71076.3 72901.3 73666.3 1144.6 1148.6 1157.3 1162.5 1166.9 13222.8 13431.3 13638.2 13673.9 13706.3 30339.1 30857.0 30871.4 30994.4 31588.8 43744.8 43772.0 43908.0 44254.8 45494.3 6994.0 7265.6 7327.7 7384.0 7437.7 10281.4 10654.7 10924.3 11027.3 11078.1 3118.9 5475.2 8881.2 9442.8 9918.2 7883.6 9113.7 9437.9 9801.6 10363.7 3225.6 3226.8 7920.7 9016.3 9291.2 6984.4 7036.4 7183.6 7185.7 7327.4 9226.0 9272.2 9294.2 9502.1 9527.7 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#3] mootools.html Cycles:180 Average:5522.32 Median:6593.14 stddev:2851.47 (43.2%) stddev-sans-first:2841.86 14:20:52 INFO - PROCESS | 19400 | Values: 1306.5 1435.7 1446.6 1578.4 1754.9 6903.3 7511.6 7645.7 7678.2 7687.5 7683.9 7869.4 7876.3 7878.1 7885.2 2030.4 2085.8 2218.9 2299.6 2341.8 2341.0 2352.2 2353.0 2353.1 2353.2 2235.0 2270.0 2285.5 2289.1 2301.8 2178.3 2192.2 2333.8 2334.6 2337.4 2265.8 2299.2 2305.1 2310.7 2340.6 8021.0 8051.2 8079.4 8080.4 8089.4 4653.7 4756.4 4762.9 4767.0 4768.1 3124.0 3166.7 3211.9 3222.5 3251.7 987.6 1003.0 1023.8 1037.4 1039.0 10814.9 10881.3 10887.4 10908.1 10916.7 4174.1 4244.9 4313.9 4320.0 4323.3 9303.6 9316.3 9333.6 9341.9 9351.3 4816.6 4820.6 4855.2 4857.3 4865.1 4408.6 4413.0 4421.3 4424.2 4427.0 3390.4 3458.4 3647.2 3677.4 3690.7 1196.7 1199.0 1205.3 1209.9 1218.9 1321.4 1327.6 1346.3 1347.5 1362.4 7131.6 7245.8 7268.6 7273.2 7275.4 1109.5 1112.4 1112.6 1113.7 1144.9 5871.5 5929.6 5931.3 5931.9 5932.6 9306.6 9398.5 9495.1 9550.8 9551.6 9453.8 9503.1 9529.3 9530.9 9531.9 7210.7 7421.7 7510.5 7519.0 7527.5 7233.4 7331.9 7333.8 7338.0 7343.6 8262.7 8378.3 8491.5 8665.2 8676.9 8297.8 8637.1 8649.3 8706.5 8722.0 6235.3 6782.9 6907.7 6926.2 6932.0 6997.8 7308.0 7526.4 7542.3 7551.8 6937.8 7070.2 7108.0 7121.5 7228.0 6859.7 6908.4 7002.5 7085.2 7100.0 6954.9 7002.2 7036.1 7041.2 7155.4 6574.8 6611.5 6614.6 6618.1 6638.8 6662.4 6686.9 6732.3 6736.6 6740.9 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#4] prototype.html Cycles:180 Average:5237.09 Median:5921.81 stddev:1546.86 (26.1%) stddev-sans-first:1506.92 14:20:52 INFO - PROCESS | 19400 | Values: 341.4 345.9 347.2 349.0 351.7 5761.9 5798.8 5876.7 5884.2 5919.0 5646.3 5839.6 5850.7 5865.0 5880.7 4517.9 4543.2 4545.2 4557.1 4560.4 4389.5 4410.8 4416.4 4494.6 4549.7 4457.9 4476.8 4482.4 4487.2 4514.7 4490.8 4508.7 4522.8 4523.8 4530.6 3995.2 3996.9 4000.9 4002.5 4010.4 5433.2 5544.8 5558.8 5639.4 5643.4 5312.4 5320.5 5322.9 5323.3 5326.8 5929.5 6254.9 6255.7 6258.1 6267.1 4323.6 4365.5 4450.6 4453.9 4463.3 6380.5 6436.3 6475.8 6476.8 6484.6 4576.9 4580.2 4581.5 4583.0 4594.5 4545.4 4623.6 4626.4 4635.3 4645.6 5227.6 5273.4 5277.7 5279.3 5283.8 6244.5 6248.0 6249.1 6254.4 6261.5 1623.8 1647.3 1649.0 1649.7 1650.7 1124.4 1131.6 1131.7 1135.0 1156.1 5924.6 5927.8 5938.0 5939.9 5940.7 6398.3 6402.1 6409.9 6412.9 6414.1 5832.9 5932.8 5935.1 5936.6 5937.1 3409.9 3456.3 3461.3 3463.8 3464.4 6629.6 6633.7 6633.9 6637.3 6642.4 6513.7 6530.4 6535.4 6538.1 6543.3 6487.1 6633.6 6634.9 6636.0 6642.6 6215.2 6349.7 6378.4 6380.5 6388.0 6234.6 6234.9 6280.5 6310.6 6399.2 6635.6 6649.1 6649.5 6662.2 6664.8 4521.6 4566.5 4598.4 4599.4 4603.0 6470.2 6473.9 6476.4 6487.3 6489.2 6285.3 6310.6 6312.7 6321.5 6321.9 6183.0 6287.7 6290.2 6300.7 6301.2 6142.1 6166.4 6190.3 6191.3 6203.1 6321.5 6332.3 6333.4 6340.5 6340.6 6087.1 6180.2 6185.6 6189.0 6192.2 14:20:52 INFO - PROCESS | 19400 | 14:20:52 INFO - PROCESS | 19400 | [#5] yui.html Cycles:180 Average:13696.68 Median:24043.66 stddev:15597.24 (64.9%) stddev-sans-first:15610.42 14:20:52 INFO - PROCESS | 19400 | Values: 693.6 831.6 832.3 834.6 835.5 13313.8 13326.6 13352.2 13427.7 13442.7 12636.9 12655.7 12699.6 14333.6 14558.4 778.4 794.0 795.6 795.7 795.7 640.9 652.2 784.0 796.7 800.4 828.0 829.8 833.7 834.8 836.4 671.3 827.9 828.0 828.3 828.4 499.9 595.9 608.1 608.7 608.9 13684.7 13719.8 13789.0 13793.9 13831.7 11932.2 12145.5 12290.8 12297.4 12672.4 9935.3 10484.1 10536.9 10561.8 10567.0 3695.4 3731.4 3737.2 3747.8 3765.2 46463.8 46819.8 47270.8 47285.8 48204.3 10354.1 10362.5 10365.6 10399.3 10529.1 18178.0 18281.9 18327.9 18335.9 18404.4 7798.0 7944.2 7981.5 8039.3 8045.1 3955.1 4029.4 4068.9 4070.3 4093.7 2883.5 2910.0 2913.5 2915.4 2919.7 533.2 534.8 547.0 548.3 572.3 529.4 573.7 626.9 634.1 682.4 8945.5 8979.7 9067.4 9099.6 9209.8 554.4 653.4 657.4 665.7 674.0 4219.4 4244.3 4246.4 4375.2 4393.9 57655.8 59282.1 59440.0 59771.4 59788.1 46887.0 47978.8 48257.8 48406.5 48758.3 43094.4 44299.1 44531.6 45848.5 46081.8 8643.3 8751.6 8877.7 9130.6 9399.9 32607.0 33255.0 33298.7 33410.3 36138.8 42437.6 42580.4 43395.8 43712.1 43923.8 10850.8 11138.7 11176.4 11252.8 11376.1 11717.0 11981.2 12061.5 12314.1 12450.9 11277.4 11687.8 11708.5 12121.8 12312.8 10868.8 11132.4 11311.3 11477.9 11913.0 8281.0 11554.7 11883.4 11965.8 12251.8 9491.0 9636.0 9782.2 9961.0 9998.6 10138.2 10155.6 10192.5 10510.3 10511.2 14:20:52 INFO - PROCESS | 19400 | -------- Summary: end -------- 14:20:52 INFO - PROCESS | 19400 | 14:20:53 INFO - TEST-INFO | 19400: exit 0 14:20:53 INFO - TEST-OK | dromaeo_css | took 1112060ms 14:20:53 INFO - TEST-START | kraken 14:20:53 INFO - operating with platform_type : linux_ 14:20:53 INFO - Initialising browser for kraken test... 14:20:53 INFO - TEST-INFO | started process 19584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7KrkGD/profile http://localhost:56814/getInfo.html) 14:20:57 INFO - PROCESS | 19584 | __metrics Screen width/height:1600/1200 14:20:57 INFO - PROCESS | 19584 | colorDepth:24 14:20:57 INFO - PROCESS | 19584 | Browser inner width/height: 1024/697 14:20:57 INFO - PROCESS | 19584 | __metrics 14:20:57 INFO - PROCESS | 19584 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:20:57 INFO - PROCESS | 19584 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:20:58 INFO - TEST-INFO | 19584: exit 0 14:20:58 INFO - Browser initialized. 14:20:58 INFO - Running cycle 1/1 for kraken test... 14:20:58 INFO - TEST-INFO | started process 19664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7KrkGD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:10 INFO - PROCESS | 19664 | RSS: Main: 149041152 14:21:10 INFO - PROCESS | 19664 | 14:21:12 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:13 INFO - PROCESS | 19664 | RSS: Main: 186621952 14:21:13 INFO - PROCESS | 19664 | 14:21:15 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-dft) 14:21:16 INFO - PROCESS | 19664 | RSS: Main: 174223360 14:21:16 INFO - PROCESS | 19664 | 14:21:19 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-fft) 14:21:19 INFO - PROCESS | 19664 | RSS: Main: 160251904 14:21:19 INFO - PROCESS | 19664 | 14:21:21 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-oscillator) 14:21:22 INFO - PROCESS | 19664 | RSS: Main: 161505280 14:21:22 INFO - PROCESS | 19664 | 14:21:24 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:21:25 INFO - PROCESS | 19664 | RSS: Main: 163651584 14:21:25 INFO - PROCESS | 19664 | 14:21:28 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-darkroom) 14:21:28 INFO - PROCESS | 19664 | RSS: Main: 163074048 14:21:28 INFO - PROCESS | 19664 | 14:21:31 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:32 INFO - PROCESS | 19664 | RSS: Main: 165117952 14:21:32 INFO - PROCESS | 19664 | 14:21:35 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56814/tests/kraken/driver.html?testName=json-parse-financial) 14:21:35 INFO - PROCESS | 19664 | RSS: Main: 163135488 14:21:35 INFO - PROCESS | 19664 | 14:21:37 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:37 INFO - PROCESS | 19664 | RSS: Main: 174862336 14:21:37 INFO - PROCESS | 19664 | 14:21:39 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:40 INFO - PROCESS | 19664 | RSS: Main: 171941888 14:21:40 INFO - PROCESS | 19664 | 14:21:42 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:43 INFO - PROCESS | 19664 | RSS: Main: 181833728 14:21:43 INFO - PROCESS | 19664 | 14:21:45 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:45 INFO - PROCESS | 19664 | RSS: Main: 189870080 14:21:46 INFO - PROCESS | 19664 | 14:21:48 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:49 INFO - PROCESS | 19664 | RSS: Main: 187326464 14:21:49 INFO - PROCESS | 19664 | 14:21:50 INFO - PROCESS | 19664 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56814/tests/kraken/driver.html?testName=ai-astar) 14:21:51 INFO - PROCESS | 19664 | RSS: Main: 245170176 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | __start_tp_report 14:21:51 INFO - PROCESS | 19664 | _x_x_mozilla_page_load 14:21:51 INFO - PROCESS | 19664 | _x_x_mozilla_page_load_details 14:21:51 INFO - PROCESS | 19664 | |i|pagename|runs| 14:21:51 INFO - PROCESS | 19664 | |0;ai-astar;109;109;104;110;110;111;102;110;111;109 14:21:51 INFO - PROCESS | 19664 | |1;audio-beat-detection;152;133;158;157;123;148;152;126;161;124 14:21:51 INFO - PROCESS | 19664 | |2;audio-dft;160;162;161;161;160;160;159;162;160;160 14:21:51 INFO - PROCESS | 19664 | |3;audio-fft;71;72;84;93;72;73;71;102;94;71 14:21:51 INFO - PROCESS | 19664 | |4;audio-oscillator;96;96;149;94;96;97;143;96;96;148 14:21:51 INFO - PROCESS | 19664 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;109;109 14:21:51 INFO - PROCESS | 19664 | |6;imaging-darkroom;145;146;144;146;144;145;146;145;145;146 14:21:51 INFO - PROCESS | 19664 | |7;imaging-desaturate;95;96;96;96;96;95;95;95;95;95 14:21:51 INFO - PROCESS | 19664 | |8;json-parse-financial;58;59;61;58;57;58;58;67;66;57 14:21:51 INFO - PROCESS | 19664 | |9;json-stringify-tinderbox;67;67;67;68;68;67;68;68;67;67 14:21:51 INFO - PROCESS | 19664 | |10;stanford-crypto-aes;84;85;84;85;92;84;86;85;86;85 14:21:51 INFO - PROCESS | 19664 | |11;stanford-crypto-ccm;114;114;120;118;123;120;124;129;121;115 14:21:51 INFO - PROCESS | 19664 | |12;stanford-crypto-pbkdf2;140;139;151;148;150;139;152;149;151;138 14:21:51 INFO - PROCESS | 19664 | |13;stanford-crypto-sha256-iterative;70;66;67;67;67;67;67;68;66;65 14:21:51 INFO - PROCESS | 19664 | __end_tp_report 14:21:51 INFO - PROCESS | 19664 | __start_cc_report 14:21:51 INFO - PROCESS | 19664 | _x_x_mozilla_cycle_collect,959 14:21:51 INFO - PROCESS | 19664 | __end_cc_report 14:21:51 INFO - PROCESS | 19664 | __startTimestamp1452291711053__endTimestamp 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | ------- Summary: start ------- 14:21:51 INFO - PROCESS | 19664 | Number of tests: 14 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.03 (2.8%) stddev-sans-first:3.21 14:21:51 INFO - PROCESS | 19664 | Values: 109.0 109.0 104.0 110.0 110.0 111.0 102.0 110.0 111.0 109.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:152.00 stddev:15.20 (10.0%) stddev-sans-first:15.80 14:21:51 INFO - PROCESS | 19664 | Values: 152.0 133.0 158.0 157.0 123.0 148.0 152.0 126.0 161.0 124.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 14:21:51 INFO - PROCESS | 19664 | Values: 160.0 162.0 161.0 161.0 160.0 160.0 159.0 162.0 160.0 160.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:11.94 (16.5%) stddev-sans-first:12.19 14:21:51 INFO - PROCESS | 19664 | Values: 71.0 72.0 84.0 93.0 72.0 73.0 71.0 102.0 94.0 71.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:24.60 (25.6%) stddev-sans-first:25.48 14:21:51 INFO - PROCESS | 19664 | Values: 96.0 96.0 149.0 94.0 96.0 97.0 143.0 96.0 96.0 148.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:21:51 INFO - PROCESS | 19664 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:21:51 INFO - PROCESS | 19664 | Values: 145.0 146.0 144.0 146.0 144.0 145.0 146.0 145.0 145.0 146.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:21:51 INFO - PROCESS | 19664 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:58.50 stddev:3.67 (6.3%) stddev-sans-first:3.82 14:21:51 INFO - PROCESS | 19664 | Values: 58.0 59.0 61.0 58.0 57.0 58.0 58.0 67.0 66.0 57.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:21:51 INFO - PROCESS | 19664 | Values: 67.0 67.0 67.0 68.0 68.0 67.0 68.0 68.0 67.0 67.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.37 (2.8%) stddev-sans-first:2.44 14:21:51 INFO - PROCESS | 19664 | Values: 84.0 85.0 84.0 85.0 92.0 84.0 86.0 85.0 86.0 85.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.50 stddev:4.80 (4.0%) stddev-sans-first:4.61 14:21:51 INFO - PROCESS | 19664 | Values: 114.0 114.0 120.0 118.0 123.0 120.0 124.0 129.0 121.0 115.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:149.50 stddev:5.89 (3.9%) stddev-sans-first:5.87 14:21:51 INFO - PROCESS | 19664 | Values: 140.0 139.0 151.0 148.0 150.0 139.0 152.0 149.0 151.0 138.0 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - PROCESS | 19664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:0.87 14:21:51 INFO - PROCESS | 19664 | Values: 70.0 66.0 67.0 67.0 67.0 67.0 67.0 68.0 66.0 65.0 14:21:51 INFO - PROCESS | 19664 | -------- Summary: end -------- 14:21:51 INFO - PROCESS | 19664 | 14:21:51 INFO - TEST-INFO | 19664: exit 0 14:21:51 INFO - TEST-OK | kraken | took 58445ms 14:21:51 INFO - TEST-START | v8_7 14:21:51 INFO - operating with platform_type : linux_ 14:21:51 INFO - Initialising browser for v8_7 test... 14:21:51 INFO - TEST-INFO | started process 19911 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuu4i35/profile http://localhost:56814/getInfo.html) 14:21:55 INFO - PROCESS | 19911 | __metrics Screen width/height:1600/1200 14:21:55 INFO - PROCESS | 19911 | colorDepth:24 14:21:55 INFO - PROCESS | 19911 | Browser inner width/height: 1024/697 14:21:55 INFO - PROCESS | 19911 | __metrics 14:21:55 INFO - PROCESS | 19911 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:21:55 INFO - PROCESS | 19911 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:56 INFO - TEST-INFO | 19911: exit 0 14:21:56 INFO - Browser initialized. 14:21:56 INFO - Running cycle 1/1 for v8_7 test... 14:21:56 INFO - TEST-INFO | started process 19996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuu4i35/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:08 INFO - PROCESS | 19996 | RSS: Main: 148275200 14:22:08 INFO - PROCESS | 19996 | 14:22:30 INFO - PROCESS | 19996 | Cycle 1(1): loaded http://localhost:56814/tests/v8_7/run.html (next: http://localhost:56814/tests/v8_7/run.html) 14:22:31 INFO - PROCESS | 19996 | RSS: Main: 586506240 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | __start_tp_report 14:22:31 INFO - PROCESS | 19996 | _x_x_mozilla_page_load 14:22:31 INFO - PROCESS | 19996 | _x_x_mozilla_page_load_details 14:22:31 INFO - PROCESS | 19996 | |i|pagename|runs| 14:22:31 INFO - PROCESS | 19996 | |0;Richards;166.38935108153078 14:22:31 INFO - PROCESS | 19996 | |1;DeltaBlue;190.15021867275146 14:22:31 INFO - PROCESS | 19996 | |2;Encrypt;279.72027972027973 14:22:31 INFO - PROCESS | 19996 | |3;Decrypt;5289.473684210527 14:22:31 INFO - PROCESS | 19996 | |4;RayTrace;1111.111111111111 14:22:31 INFO - PROCESS | 19996 | |5;Earley;791.1392405063291 14:22:31 INFO - PROCESS | 19996 | |6;Boyer;12353.658536585366 14:22:31 INFO - PROCESS | 19996 | |7;RegExp;42500 14:22:31 INFO - PROCESS | 19996 | |8;Splay;654.4502617801047 14:22:31 INFO - PROCESS | 19996 | |9;NavierStokes;4830.917874396136 14:22:31 INFO - PROCESS | 19996 | __end_tp_report 14:22:31 INFO - PROCESS | 19996 | __startTimestamp1452291751100__endTimestamp 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | ------- Summary: start ------- 14:22:31 INFO - PROCESS | 19996 | Number of tests: 10 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 166.4 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#1] DeltaBlue Cycles:1 Average:190.15 Median:190.15 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 190.2 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 279.7 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#3] Decrypt Cycles:1 Average:5289.47 Median:5289.47 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 5289.5 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#4] RayTrace Cycles:1 Average:1111.11 Median:1111.11 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 1111.1 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 791.1 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 12353.7 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#7] RegExp Cycles:1 Average:42500.00 Median:42500.00 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 42500.0 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#8] Splay Cycles:1 Average:654.45 Median:654.45 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 654.5 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - PROCESS | 19996 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:22:31 INFO - PROCESS | 19996 | Values: 4830.9 14:22:31 INFO - PROCESS | 19996 | -------- Summary: end -------- 14:22:31 INFO - PROCESS | 19996 | 14:22:31 INFO - TEST-INFO | 19996: exit 0 14:22:31 INFO - TEST-OK | v8_7 | took 40021ms 14:22:31 INFO - SUITE-END | took 1210s 14:22:32 INFO - Completed test suite (00:20:10) 14:22:32 INFO - Working with test: dromaeo_css 14:22:32 INFO - Generating results file: dromaeo_css 14:22:32 INFO - Working with test: kraken 14:22:32 INFO - Generating results file: kraken 14:22:32 INFO - javascript benchmark 14:22:32 INFO - Working with test: v8_7 14:22:32 INFO - Generating results file: v8_7 14:22:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:22:32 INFO - process_Request line: dromaeo_css 6714.35 graph.html#tests=[[72,64,35]] 14:22:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:32 INFO - process_Request line: kraken 1498.70 graph.html#tests=[[232,64,35]] 14:22:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:22:32 INFO - process_Request line: v8_7 19802.00 graph.html#tests=[[230,64,35]] 14:22:32 INFO - RETURN: dromaeo_css: 6714.35 14:22:32 INFO - RETURN: kraken: 1498.70 14:22:32 INFO - RETURN: v8_7: 19802.00 14:22:32 INFO - javascript benchmark 14:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3108.8756449742014, 3162.826044567548, 3162.9999999999986, 3183.060997005883, 3202.2474718441163, 4985.601151907847, 5095.745212739367, 5129.512696293856, 5139.820106296275, 5182.559482443992, 5059.266406371084, 5151.871203219921, 5196.272521846944, 5228.973855130719, 5230.6600070995355, 4521.276595744682, 4598.241290187124, 4629.814807407716, 4647.9535204647855, 4821.4696383397795, 4690.882727931795, 4748.311494833247, 4760.880977975544, 4800.1119792838435, 4860.0, 4639.744814035227, 4694.201985662446, 4695.506971767949, 4734.100520901018, 4755.405574303212, 4666.23007203811, 4693.507181745936, 4693.741844198567, 4718.740469274188, 4721.551452611996, 4643.955110100234, 4669.159551280768, 4681.133990211822, 4703.905921881543, 4753.239481682914, 5002.774875130628, 5096.566791822699, 5097.0315640028275, 5113.2330150477355, 5113.53978141969, 5569.526590239834, 5604.2714447122025, 5612.214289999403, 5614.831555053355, 5617.893737291359, 5504.339479262514, 5554.750036248379, 5606.187102870061, 5639.605227634026, 5677.403872593401, 5224.08578498765, 5243.056249875059, 5246.97376513115, 5255.658382205144, 5258.0, 5691.0, 5723.084306510938, 5725.312962444534, 5728.083506639001, 5728.283964504437, 5388.784448622089, 5455.345358556999, 5483.232347471358, 5539.14143307788, 5540.750666219949, 5574.470425309589, 5624.91562626561, 5632.5775566831835, 5633.492985631231, 5634.802781902696, 5546.694931778791, 5601.943980560142, 5606.046972014768, 5610.32676078865, 5613.129964855454, 5368.32895888014, 5488.588355873326, 5557.499825015768, 5566.081596536526, 5599.664020158803, 4332.956670433256, 4333.826646934087, 4347.6304514116655, 4371.693981421334, 4373.518912919576, 3850.306944749916, 3861.8841434757, 3874.8450061997205, 3917.0794863207125, 3917.2948869203815, 5014.6991180529285, 5130.127878260705, 5179.948200518022, 5187.221916712523, 5205.167173252262, 5470.5350045245805, 5472.5621950243885, 5476.644018138808, 5487.6158668893595, 5523.558115350762, 5116.820911268088, 5130.384353877558, 5132.0, 5136.691798492103, 5177.0, 4532.184206842734, 4612.3542704021465, 4690.0, 4719.0, 4780.904381912412, 5748.252727145528, 5750.1949727038245, 5760.913586296209, 5775.393583673654, 5790.102534107136, 5521.558275337883, 5534.308211473566, 5534.889302214014, 5538.529225015919, 5549.916751248816, 5536.52939500147, 5635.549156067586, 5727.39862314451, 5743.253377060955, 5743.59794814359, 5415.512603865671, 5419.105847535113, 5426.484483974016, 5427.13165893471, 5456.236126942311, 5469.15228139639, 5470.72646367672, 5476.041692703681, 5494.532964697885, 5529.391766905717, 5251.36983561975, 5351.2508248844415, 5405.405405405324, 5436.918446223389, 5574.498295153456, 5335.199720042025, 5343.919841202307, 5363.115086010765, 5377.946220537745, 5383.273258110262, 5279.39286982002, 5282.762275697526, 5288.365396152486, 5299.284596579567, 5334.67991920486, 5321.600879933943, 5391.137418013099, 5408.5673146149, 5449.809256676156, 5507.421720719427, 5229.712365819916, 5230.712310822942, 5231.973840130775, 5244.213367994678, 5302.867428314323], "unit": "score", "name": "dojo.html", "value": 5107.714543221695}, {"lowerIsBetter": false, "replicates": [524.7087866234239, 530.8832056947472, 543.5651478816945, 562.0585519255246, 566.3402136510965, 27936.860315698417, 28561.0, 35624.64375356246, 36438.271234575295, 36455.4531682025, 38521.61478385215, 38630.0, 38718.80640596793, 38903.80548097256, 38927.0, 8342.624581893799, 8508.702195423162, 8537.658493660247, 8540.316774658044, 8540.615672294762, 8352.12302708216, 8459.492430454193, 8462.069172391031, 8473.322134229278, 8488.066312705598, 8381.45520541166, 8533.402661813676, 8724.8691269631, 8733.7816554586, 8737.825243495126, 8558.657653693845, 8587.270082043035, 8593.914060859373, 8672.436291641086, 8674.739757807245, 8464.534450605213, 8588.656453741844, 8607.569621518898, 8609.440386374928, 8619.1811777881, 38985.0, 39257.214855702725, 39385.0, 39498.80250598757, 39528.20943581112, 3138.107659237021, 3184.6656101109284, 3306.2230375861895, 3373.713234375081, 3440.70753985909, 28078.438431231465, 30286.69713302883, 30387.544186837215, 30455.0, 30716.846415768003, 3842.4620553122304, 4046.0491784430637, 4064.8374065037365, 4077.7145599808027, 4154.937675934863, 263752.0, 264403.9999999981, 264576.0, 265659.0, 265665.0, 51083.0, 51699.483005170216, 52003.219951700754, 52079.73960130175, 52148.21777673338, 47888.760556197, 62657.373426266066, 63800.36199637944, 63868.68065659642, 63915.36084639094, 14740.262986850614, 15172.468963586221, 15181.62045948838, 15188.848111518964, 15210.847891520943, 9962.551685174185, 10047.24645651579, 10591.152707783358, 10605.25763196569, 11033.668989930315, 18753.0, 18947.715784263248, 19060.332888348843, 19112.426627201206, 19137.521561960784, 7020.5787652741, 7210.242924492957, 7338.0, 7365.337119659256, 7418.332350088518, 943.6366998705548, 974.6247694637474, 1042.2339580408393, 1053.2785042246087, 1069.7539565899888, 26478.86760566185, 28095.71904280972, 28212.576811347848, 28247.57628635572, 28459.28851778681, 1016.1819735113305, 1065.0840277361463, 1076.956921723138, 1117.664700589836, 1198.1553005131361, 14564.708705826037, 14646.439443085812, 14693.632659183391, 14961.551153465414, 15007.424220456694, 314871.0, 318182.0, 318805.0, 319425.0, 320053.0, 49001.50998490041, 49532.0, 49618.75190624096, 49754.25368619474, 49870.501294986585, 1291.5802364231663, 1293.4050336844969, 1310.7640624687647, 1316.374722007039, 1319.7162610038888, 27117.457650847267, 28056.71943280541, 28153.296167595974, 28953.420931581673, 30814.845925770227, 48508.0, 49874.0, 50150.24774628456, 50184.74907625438, 50204.0, 245186.0, 246883.0, 247350.0, 247524.0, 247921.0, 27296.0, 31044.689553105083, 31484.0, 31517.684823151474, 31947.68052319447, 36819.63180368162, 37193.44209836909, 37266.441003384425, 37943.81028094842, 38046.429303561024, 29962.70037299599, 32015.039548813573, 34061.97814065582, 36076.81961590175, 36335.81832090823, 31793.0, 32279.193020174684, 32337.19157020999, 32570.83714581412, 32658.673413265562, 32179.51730723994, 32483.35033299368, 32678.183045423102, 32767.672323276463, 32767.836160819043, 29271.0, 31002.224944376572, 31498.842505787325, 31513.684863151993, 31557.211069723442, 24048.51902961966, 24092.277231683078, 24092.277231683078, 24298.878505607358, 24353.878230609444], "unit": "score", "name": "ext.html", "value": 17741.43692156656}, {"lowerIsBetter": false, "replicates": [356.12215887836476, 356.5632100676671, 357.67272945255087, 357.967782899539, 359.88843458527856, 13555.52555660552, 14109.788353174685, 15861.68276634468, 15991.0, 16613.750793738105, 14719.705605887875, 15433.382664693427, 15904.84095159048, 15956.0, 15963.84036159638, 5032.54707076364, 5180.1970694542215, 5214.348206474191, 5223.582113430916, 5229.137192363274, 3900.824462899162, 4056.229316429869, 5132.409772876111, 5234.26720259164, 5505.366882808468, 5810.605197032243, 5821.097729851858, 5879.412058794108, 5887.88224235515, 5890.293164820207, 5714.114312281603, 5896.0, 5903.822885313448, 5907.5864689471755, 5914.674692891889, 5141.30592370029, 5203.713795741232, 5205.609579281569, 5366.034113859504, 5377.327834020747, 19139.521511962314, 19411.126499307564, 19921.701174482394, 20521.281755138647, 20550.0, 2024.9392518224477, 2192.0683709423593, 2230.542738738555, 2354.058376649337, 2385.8329916905823, 12509.874901250962, 12669.936650316782, 12893.935530322382, 12983.545575904798, 13341.066125371228, 1824.5894673698444, 1863.5527473406285, 1864.729614205946, 1887.4620733091003, 1893.640208360407, 53811.46188538104, 57018.714906425615, 57355.42644573543, 58037.075036607086, 58916.70541647264, 9461.290403219786, 9565.282603804742, 9832.803343933225, 9833.360831545926, 9894.752631184278, 12808.231506109663, 12834.743305133845, 12910.870891291155, 12912.741745165044, 12913.09608327408, 7471.066116735408, 7491.213422590658, 7606.619669016527, 7650.2349765023055, 7657.310842024244, 7444.962775186089, 7472.589007604525, 7476.140243871915, 7554.697812087565, 7556.962215188999, 5874.148248503943, 5875.941240587539, 5905.881882362414, 5932.169496270526, 5935.139404786281, 1653.3138747419687, 1702.378631799409, 1733.930642774275, 1765.2497688482345, 1794.9910250448663, 412.79979210083684, 436.9279068953651, 444.1095603315332, 451.82830524400515, 989.5744829723288, 9370.437773733598, 9687.321887467951, 9874.308798384043, 10035.0, 10571.15430765537, 431.5662758927258, 451.7989494674838, 460.3922821875093, 894.1639567004742, 958.1089586684311, 8473.872891906627, 8591.3556483264, 8721.825563488695, 8786.692465763668, 8804.0, 148059.0, 148270.25864870608, 149426.0, 149941.0, 150073.0, 69325.3067469329, 69552.0, 71076.289237108, 72901.27098729051, 73666.26333736701, 1144.5879483385975, 1148.6209550848366, 1157.3345326437332, 1162.5001249462644, 1166.8658104317942, 13222.801657974946, 13431.328433578477, 13638.181709097486, 13673.863261367656, 13706.314684265946, 30339.117783810503, 30857.0, 30871.382572348877, 30994.380112397175, 31588.842055789573, 43744.78127609342, 43772.0, 43908.0, 44254.77872610616, 45494.317585235585, 6994.0, 7265.600391978492, 7327.74352897646, 7384.040074790243, 7437.665305061393, 10281.383117013003, 10654.680359589225, 10924.2899211551, 11027.345898115347, 11078.113750899747, 3118.875244990266, 5475.151351540518, 8881.245094167069, 9442.763930901783, 9918.156956658477, 7883.566403847614, 9113.681021164228, 9437.867455905336, 9801.607935682778, 10363.740906477398, 3225.580674512298, 3226.790258633181, 7920.663404295631, 9016.323775716717, 9291.2102471288, 6984.40632546219, 7036.437085033082, 7183.568985860865, 7185.712571497082, 7327.35134594712, 9225.953870230605, 9272.211861991806, 9294.209992150472, 9502.097300756417, 9527.666531671359], "unit": "score", "name": "jquery.html", "value": 7468.421910491434}, {"lowerIsBetter": false, "replicates": [1306.5361796562215, 1435.676972681147, 1446.5660301909427, 1578.4475433598243, 1754.9473515794523, 6903.3096690331, 7511.586862722548, 7645.694172233104, 7678.232176782319, 7687.500312479685, 7683.9231607683905, 7869.409794265424, 7876.291133797957, 7878.094019187795, 7885.172056934025, 2030.3908827351809, 2085.8435617328687, 2218.8557743746646, 2299.586074506588, 2341.7775311345395, 2340.9882950585225, 2352.1767381416453, 2352.999975010622, 2353.0940587873706, 2353.235198560466, 2235.0, 2269.9558203226534, 2285.4743409015937, 2289.072925465181, 2301.8158547316257, 2178.3356076396694, 2192.210804110519, 2333.7666233376694, 2334.579775640384, 2337.357226762637, 2265.784750448705, 2299.1608063057033, 2305.13557415969, 2310.6649535817214, 2340.5552944940578, 8020.959895200545, 8051.154628763954, 8079.394045446556, 8080.39397045224, 8089.393295502802, 4653.650976176767, 4756.405449318835, 4762.880927976794, 4767.046590681877, 4768.094062128219, 3123.9531407028912, 3166.746660267173, 3211.8715251389917, 3222.4682927316962, 3251.6748325167296, 987.6395115782759, 1002.9949850250702, 1023.800358930009, 1037.3827572594294, 1038.9688309350731, 10814.891851081546, 10881.292715973437, 10887.401192934385, 10908.072813810835, 10916.727081822939, 4174.08170202555, 4244.893877653021, 4313.9137217255475, 4319.956800431955, 4323.286657701507, 9303.627854885865, 9316.301277404222, 9333.626654933862, 9341.906580934103, 9351.345405821527, 4816.590589799906, 4820.590249828733, 4855.223164293767, 4857.319975203474, 4865.148598995162, 4408.603225709701, 4412.977935110304, 4421.336799480104, 4424.181526417623, 4426.955730442719, 3390.4405773047665, 3458.412069948115, 3647.2310929199316, 3677.3932301170544, 3690.7231957603285, 1196.6948428150765, 1198.9700257493632, 1205.2708111592535, 1209.8608660004213, 1218.945147468366, 1321.4119716725966, 1327.588447581253, 1346.3402932562974, 1347.5485712286493, 1362.4073528015344, 7131.607761573163, 7245.818854528574, 7268.563886166847, 7273.16358618755, 7275.4179665626625, 1109.4896347680158, 1112.3826276416667, 1112.5660992213043, 1113.7382715061954, 1144.8969592736694, 5871.471567558855, 5929.6145750526075, 5931.347551769302, 5931.911021334683, 5932.58471906971, 9306.581203845843, 9398.530073496298, 9495.097965693249, 9550.808983820285, 9551.617935282511, 9453.810923781486, 9503.097205765442, 9529.285303602257, 9530.90469095314, 9531.904680953241, 7210.71157153708, 7421.666025028887, 7510.474266801271, 7518.962405188048, 7527.473076884566, 7233.3851622612665, 7331.890021649786, 7333.779986600411, 7337.963310183415, 7343.596102214429, 8262.669493220445, 8378.287845533197, 8491.5329656867, 8665.220130188314, 8676.869846952428, 8297.751067467985, 8637.093105223861, 8649.264812490757, 8706.521141337287, 8721.956390218009, 6235.251769787473, 6782.8643427132165, 6907.723691052302, 6926.238113807578, 6931.965340173267, 6997.755078572225, 7307.9634601828775, 7526.360259377795, 7542.2834830691, 7551.811204719926, 6937.82655433598, 7070.222275549582, 7107.964460177873, 7121.501494895515, 7227.9638601806655, 6859.691313890987, 6908.378245957888, 7002.474814388839, 7085.185203701641, 7100.0414943981905, 6954.9304506956305, 7002.159740831133, 7036.050133231948, 7041.155061392461, 7155.356017958408, 6574.76988305407, 6611.504137189634, 6614.570052946543, 6618.139641846529, 6638.800835974928, 6662.367075127855, 6686.866262674622, 6732.3267673232285, 6736.629485378351, 6740.8651826962205], "unit": "score", "name": "mootools.html", "value": 4548.477636907745}, {"lowerIsBetter": false, "replicates": [341.4093618040789, 345.8858576669699, 347.1529468097841, 349.02273633825286, 351.6562113513433, 5761.9135712964335, 5798.768049278035, 5876.676782776951, 5884.205632239647, 5918.970405147974, 5646.2942132233475, 5839.620424672404, 5850.707464626762, 5865.0, 5880.735366908489, 4517.887052823689, 4543.227651299287, 4545.204589196894, 4557.065801510699, 4560.361549383089, 4389.4513185851765, 4410.75740834254, 4416.381706561084, 4494.550544945512, 4549.658775591827, 4457.9331310030375, 4476.843310484133, 4482.439695038121, 4487.237169681162, 4514.661400394967, 4490.787487378406, 4508.6618503612035, 4522.751248681321, 4523.751193684346, 4530.59224669778, 3995.1610161866042, 3996.9400458993136, 4000.9199816003807, 4002.459667944848, 4010.438538604598, 5433.212184233304, 5544.833654990316, 5558.805441809517, 5639.436056394369, 5643.435656434365, 5312.362516498045, 5320.494553017457, 5322.946770532284, 5323.254744335757, 5326.786928522854, 5929.525637948954, 6254.906176407358, 6255.718492667841, 6258.06129080637, 6267.091271765568, 4323.567643235683, 4365.519792822787, 4450.643948484114, 4453.910921781546, 4463.308187230952, 6380.457661098812, 6436.259830119549, 6475.838104047437, 6476.773312934025, 6484.578502397329, 4576.908461830745, 4580.198465268565, 4581.473130590025, 4583.0, 4594.47163576193, 4545.38637283969, 4623.606993405599, 4626.352310676508, 4635.304704294383, 4645.628349732014, 5227.581793456515, 5273.446288139767, 5277.709725965032, 5279.313689220377, 5283.762230699551, 6244.46922011625, 6247.96876015617, 6249.0938813871735, 6254.405831446005, 6261.530385221126, 1623.8294979027269, 1647.2916645842404, 1648.983510164907, 1649.6783127290064, 1650.6946214950271, 1124.3872089711126, 1131.575659127827, 1131.7340425000118, 1134.9886501135047, 1156.115571587736, 5924.644521328734, 5927.822165334961, 5937.970310148422, 5939.910901336483, 5940.70296485174, 6398.2641996170105, 6402.135711678957, 6409.935900641027, 6412.871742565123, 6414.102025716404, 5832.88334233313, 5932.822015339547, 5935.050391937356, 5936.614120082181, 5937.139114828326, 3409.9488507672404, 3456.274182421669, 3461.2558299965626, 3463.8268086595567, 3464.4283693190846, 6629.602223866584, 6633.701483433257, 6633.872241718919, 6637.269900310962, 6642.4021838034805, 6513.739450422025, 6530.379613936669, 6535.44448721864, 6538.084668146464, 6543.280239173687, 6487.091807147003, 6633.635150066792, 6634.933650663528, 6635.966820165965, 6642.568233064932, 6215.223097112861, 6349.650769207553, 6378.362163783585, 6380.457661098859, 6388.0, 6234.625922444668, 6234.937650623436, 6280.466160376419, 6310.558260921692, 6399.232092148972, 6635.6350400728425, 6649.069130321662, 6649.46804255668, 6662.233843108104, 6664.766733164316, 4521.638268938543, 4566.4748553916725, 4598.3792188054185, 4599.448066232074, 4603.0, 6470.22357317125, 6473.870522589427, 6476.352364763486, 6487.253965793805, 6489.1888513935755, 6285.340039295808, 6310.558260921875, 6312.747490100344, 6321.52588555851, 6321.905171422524, 6183.0, 6287.74849006053, 6290.150829637941, 6300.684965751602, 6301.212348456443, 6142.140100386039, 6166.383361663977, 6190.2571691397325, 6191.25704915413, 6203.100550420254, 6321.462675672436, 6332.30344662096, 6333.36666333363, 6340.541675414588, 6340.556161068681, 6087.117367981707, 6180.165677633462, 6185.567010309415, 6189.04069869171, 6192.164057852132], "unit": "score", "name": "prototype.html", "value": 4744.474533493242}, {"lowerIsBetter": false, "replicates": [693.5838496901858, 831.5925196653642, 832.2676045080328, 834.557684427253, 835.5446281776432, 13313.8002929956, 13326.600201993955, 13352.198868067922, 13427.731445371086, 13442.731145377098, 12636.93681531591, 12655.683607909807, 12699.619011429671, 14333.641658958506, 14558.417663293481, 778.3656320099116, 794.0074906367041, 795.6300320351036, 795.7214974758846, 795.7493389582263, 640.8878446271907, 652.2043107408978, 784.0434669702953, 796.749024057423, 800.4436916343144, 827.9917200827974, 829.8215883585028, 833.7165363776314, 834.7954751085992, 836.3601844588894, 671.3454381977582, 827.9047909490396, 828.035338830262, 828.349745449819, 828.353883970504, 499.932509111269, 595.9344472108108, 608.069653430248, 608.6895683201554, 608.8843119807267, 13684.65788355289, 13719.794203086962, 13789.0, 13793.931030344884, 13831.723365532735, 11932.22440541362, 12145.514179432812, 12290.75418491634, 12297.385130743427, 12672.366381680971, 9935.304528682995, 10484.108850747696, 10536.947315263375, 10561.838197798235, 10567.0, 3695.371786796251, 3731.440283957401, 3737.2338670572467, 3747.775133491972, 3765.152840610868, 46463.76768116171, 46819.76590117062, 47270.76364618189, 47285.763571182266, 48204.27693584599, 10354.11989980845, 10362.533685984148, 10365.63720269787, 10399.27205095636, 10529.105026072717, 18178.0, 18281.908590457228, 18327.90836045838, 18335.90832045858, 18404.447866564024, 7797.961010194913, 7944.165862584346, 7981.48120372174, 8039.276465118168, 8045.07481639619, 3955.0705584187695, 4029.4157347185082, 4068.898277543085, 4070.3487442009136, 4093.7339072960162, 2883.480973424762, 2909.956350654742, 2913.548399998004, 2915.4169166166853, 2919.693432189632, 533.2294833964884, 534.7513406266105, 546.9535089517356, 548.2954403591366, 572.3046498504337, 529.4123522889589, 573.6529399713197, 626.8808926303988, 634.096412612026, 682.4097155960158, 8945.46327220369, 8979.685711000084, 9067.35364768015, 9099.636014559475, 9209.764211422607, 554.4206304411899, 653.3858173317067, 657.4471782903375, 665.7403612591094, 673.9730410783612, 4219.367094935784, 4244.3209086546, 4246.40550322955, 4375.190589740908, 4393.868183954486, 57655.81097701227, 59282.11076833851, 59440.0, 59771.402285977456, 59788.10317845236, 46887.0, 47978.760106199945, 48257.75871120622, 48406.51593484091, 48758.26862597064, 43094.35358469688, 44299.11401771947, 44531.55468445339, 45848.54151458509, 46081.76959115183, 8643.265322447662, 8751.562421879007, 8877.689280875138, 9130.634774608941, 9399.85900211511, 32607.0, 33255.0, 33298.667013329556, 33410.33179336448, 36138.819305904355, 42437.5756242446, 42580.36129458123, 43395.783021084695, 43712.12575748531, 43923.78038109789, 10850.782984340427, 11138.721531961442, 11176.441177941233, 11252.83120753173, 11376.08991280679, 11717.00405465545, 11981.161318707607, 12061.51753929868, 12314.13801033919, 12450.937745311216, 11277.436128193722, 11687.76624467523, 11708.47311870985, 12121.757564848478, 12312.81530777057, 10868.836967445337, 11132.387718675227, 11311.264767790068, 11477.942610286895, 11913.046956243654, 8280.951215980613, 11554.711132221426, 11883.405829708652, 11965.820512692142, 12251.816222756488, 9490.952545237229, 9636.0, 9782.217422606032, 9961.0, 9998.550065246936, 10138.23963202748, 10155.644552440925, 10192.490375481344, 10510.264281500222, 10511.159107271553], "unit": "score", "name": "yui.html", "value": 6273.206767664088}], "name": "dromaeo_css", "value": 6714.349973349075}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 110.0, 110.0, 111.0, 102.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 158.0, 157.0, 123.0, 148.0, 152.0, 126.0, 161.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 160.0, 160.0, 159.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 93.0, 72.0, 73.0, 71.0, 102.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 94.0, 96.0, 97.0, 143.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 144.0, 146.0, 144.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 61.0, 58.0, 57.0, 58.0, 58.0, 67.0, 66.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 92.0, 84.0, 86.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [114.0, 114.0, 120.0, 118.0, 123.0, 120.0, 124.0, 129.0, 121.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 151.0, 148.0, 150.0, 139.0, 152.0, 149.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1498.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [190.15021867275146], "unit": "score", "name": "DeltaBlue", "value": 347.714562}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5289.473684210527], "unit": "score", "name": "Decrypt", "value": 50.32277611940295}, {"lowerIsBetter": false, "replicates": [1111.111111111111], "unit": "score", "name": "RayTrace", "value": 665.9901}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [42500.0], "unit": "score", "name": "RegExp", "value": 21.434941176470574}, {"lowerIsBetter": false, "replicates": [654.4502617801047], "unit": "score", "name": "Splay", "value": 124.51824800000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19802.001615679852}]} 14:22:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19802.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6714.35"}}} 14:22:32 INFO - Return code: 0 14:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:22:32 INFO - # TBPL SUCCESS # 14:22:32 INFO - Running post-action listener: _resource_record_post_action 14:22:32 INFO - Running post-run listener: _resource_record_post_run 14:22:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 542253056; Read time: 0; Write time: 492212 14:22:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239063040; Read time: 0; Write time: 293376 14:22:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 303190016; Read time: 0; Write time: 198836 14:22:33 INFO - Running post-run listener: _upload_blobber_files 14:22:33 INFO - Blob upload gear active. 14:22:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:22:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:22:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:22:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:22:33 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:34 INFO - (blobuploader) - INFO - Done attempting. 14:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:35 INFO - (blobuploader) - INFO - Done attempting. 14:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:35 INFO - Return code: 0 14:22:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f478c00533dc5677faca2394f990d8f1f8987438e3b1f693f154214d407e2e218692927db69985fd8137e3be84e666852e381ddab70e359a66e35d1f8d1afab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95760024f9d9206eb78c11b5cc9e0169246336ee88059184f54cd8be44a538d61a4c3b7527c2ceeb6522d560c21c27c576a92f2fa2b208c6f931bf1c62055087"} 14:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:22:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:22:35 INFO - Contents: 14:22:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f478c00533dc5677faca2394f990d8f1f8987438e3b1f693f154214d407e2e218692927db69985fd8137e3be84e666852e381ddab70e359a66e35d1f8d1afab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95760024f9d9206eb78c11b5cc9e0169246336ee88059184f54cd8be44a538d61a4c3b7527c2ceeb6522d560c21c27c576a92f2fa2b208c6f931bf1c62055087"} 14:22:35 INFO - Copying logs to upload dir... 14:22:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.609194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-08 14:22:35.349362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 14:22:35.353176) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f478c00533dc5677faca2394f990d8f1f8987438e3b1f693f154214d407e2e218692927db69985fd8137e3be84e666852e381ddab70e359a66e35d1f8d1afab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95760024f9d9206eb78c11b5cc9e0169246336ee88059184f54cd8be44a538d61a4c3b7527c2ceeb6522d560c21c27c576a92f2fa2b208c6f931bf1c62055087"} build_url:https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/atPdRc-tTDSCADuFIcF0iA/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/Fx-Team/sha512/f478c00533dc5677faca2394f990d8f1f8987438e3b1f693f154214d407e2e218692927db69985fd8137e3be84e666852e381ddab70e359a66e35d1f8d1afab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95760024f9d9206eb78c11b5cc9e0169246336ee88059184f54cd8be44a538d61a4c3b7527c2ceeb6522d560c21c27c576a92f2fa2b208c6f931bf1c62055087"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 14:22:35.382662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:22:35.383459) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452290443.728035-892205651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 14:22:35.466505) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 14:22:35.467302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 14:22:35.468004) ========= ========= Total master_lag: 0.25 =========