builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1452951555.68 results: success (0) buildid: 20160116030240 builduid: 10c4f8b1dacc4705a1199c49ce82fb5b revision: 9879757aa0d4f88df8c79cde4a777ac7eff0152f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.676370) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.676745) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.677016) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006421 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.705892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.706176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.731416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.731695) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.783685) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.783941) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.784272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.784567) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 05:39:16-- 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% 83.7M=0s 2016-01-16 05:39:16 (83.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.963286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:15.963597) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.117135 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.092349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.092690) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9879757aa0d4f88df8c79cde4a777ac7eff0152f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9879757aa0d4f88df8c79cde4a777ac7eff0152f --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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 05:39:16,452 truncating revision to first 12 chars 2016-01-16 05:39:16,452 Setting DEBUG logging. 2016-01-16 05:39:16,452 attempt 1/10 2016-01-16 05:39:16,452 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9879757aa0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 05:39:16,825 unpacking tar archive at: mozilla-central-9879757aa0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.791028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.791347) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004724 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.843175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.843471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.856689) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.856928) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 05:39:16.857340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-16 05:39:16.857666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:17 INFO - MultiFileLogger online at 20160116 05:39:17 in /builds/slave/test-pgo 05:39:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:39:17 INFO - {'append_to_log': False, 05:39:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:39:17 INFO - 'blob_upload_branch': 'Firefox', 05:39:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:39:17 INFO - 'branch': 'Firefox', 05:39:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:17 INFO - 'config_files': ('talos/linux_config.py',), 05:39:17 INFO - 'default_actions': ('clobber', 05:39:17 INFO - 'read-buildbot-config', 05:39:17 INFO - 'download-and-extract', 05:39:17 INFO - 'populate-webroot', 05:39:17 INFO - 'create-virtualenv', 05:39:17 INFO - 'install', 05:39:17 INFO - 'run-tests'), 05:39:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:17 INFO - 'download_minidump_stackwalk': True, 05:39:17 INFO - 'download_symbols': 'ondemand', 05:39:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:17 INFO - 'installer_path': 'installer.exe', 05:39:17 INFO - 'log_level': 'info', 05:39:17 INFO - 'log_name': 'talos', 05:39:17 INFO - 'log_to_console': True, 05:39:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:17 INFO - 'opt_config_files': (), 05:39:17 INFO - 'pip_index': False, 05:39:17 INFO - 'sps_profile': False, 05:39:17 INFO - 'sps_profile_interval': 0, 05:39:17 INFO - 'suite': 'dromaeojs', 05:39:17 INFO - 'system_bits': '32', 05:39:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:17 INFO - 'title': 'talos-linux64-ix-019', 05:39:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:17 INFO - 'use_talos_json': True, 05:39:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:39:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:17 INFO - 'work_dir': 'build'} 05:39:17 INFO - ##### 05:39:17 INFO - ##### Running clobber step. 05:39:17 INFO - ##### 05:39:17 INFO - Running pre-action listener: _resource_record_pre_action 05:39:17 INFO - Running main action method: clobber 05:39:17 INFO - rmtree: /builds/slave/test-pgo/build 05:39:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:39:21 INFO - Running post-action listener: _resource_record_post_action 05:39:21 INFO - ##### 05:39:21 INFO - ##### Running read-buildbot-config step. 05:39:21 INFO - ##### 05:39:21 INFO - Running pre-action listener: _resource_record_pre_action 05:39:21 INFO - Running main action method: read_buildbot_config 05:39:21 INFO - Using buildbot properties: 05:39:21 INFO - { 05:39:21 INFO - "project": "", 05:39:21 INFO - "product": "firefox", 05:39:21 INFO - "script_repo_revision": "production", 05:39:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:39:21 INFO - "repository": "", 05:39:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:39:21 INFO - "buildid": "20160116030240", 05:39:21 INFO - "stage_platform": "linux64-pgo", 05:39:21 INFO - "basedir": "/builds/slave/test-pgo", 05:39:21 INFO - "nightly_build": "True", 05:39:21 INFO - "buildnumber": 161, 05:39:21 INFO - "slavename": "talos-linux64-ix-019", 05:39:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:21 INFO - "platform": "ubuntu64_hw", 05:39:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:39:21 INFO - "branch": "mozilla-central", 05:39:21 INFO - "repo_path": "mozilla-central", 05:39:21 INFO - "revision": "9879757aa0d4f88df8c79cde4a777ac7eff0152f", 05:39:21 INFO - "pgo_build": "True", 05:39:21 INFO - "builduid": "10c4f8b1dacc4705a1199c49ce82fb5b", 05:39:21 INFO - "slavebuilddir": "test" 05:39:21 INFO - } 05:39:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:39:21 INFO - Running post-action listener: _resource_record_post_action 05:39:21 INFO - ##### 05:39:21 INFO - ##### Running download-and-extract step. 05:39:21 INFO - ##### 05:39:21 INFO - Running pre-action listener: _resource_record_pre_action 05:39:21 INFO - Running main action method: download_and_extract 05:39:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:21 INFO - https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:39:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/test_packages.json 05:39:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/test_packages.json 05:39:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:39:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:39:26 INFO - Downloaded 1448 bytes. 05:39:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:39:26 INFO - Using the following test package requirements: 05:39:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:26 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'jsshell-linux-x86_64.zip'], 05:39:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:26 INFO - https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:36 INFO - Downloaded 22441132 bytes. 05:39:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:38 INFO - Return code: 0 05:39:38 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 05:39: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')]} 05:39:38 INFO - https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:41 INFO - Downloaded 22441132 bytes. 05:39:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:43 INFO - Return code: 0 05:39: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')]} 05:39:43 INFO - https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:45 INFO - Downloaded 11132144 bytes. 05:39:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:39:46 INFO - Return code: 0 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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 05:39:49 INFO - Downloaded 55884669 bytes. 05:39:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:49 INFO - mkdir: /builds/slave/test-pgo/properties 05:39:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:39:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:39:49 INFO - Contents: 05:39:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:49 INFO - Running post-action listener: _resource_record_post_action 05:39:49 INFO - Running post-action listener: set_extra_try_arguments 05:39:49 INFO - ##### 05:39:49 INFO - ##### Running populate-webroot step. 05:39:49 INFO - ##### 05:39:49 INFO - Running pre-action listener: _resource_record_pre_action 05:39:49 INFO - Running main action method: populate_webroot 05:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:49 INFO - '--tppagecycles', 05:39:49 INFO - '7'], 05:39:49 INFO - 'tests': ['tsvgm']}}, 05:39:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:39:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['damp', 'tps']}, 05:39:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['damp', 'tps']}, 05:39:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:49 INFO - 'other': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other_l64': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:39:49 INFO - 'ts_paint', 05:39:49 INFO - 'tpaint', 05:39:49 INFO - 'sessionrestore', 05:39:49 INFO - 'sessionrestore_no_auto_restore']}, 05:39:49 INFO - 'svgr': {'tests': ['tsvgx', 05:39:49 INFO - 'tsvgr_opacity', 05:39:49 INFO - 'tart', 05:39:49 INFO - 'tscrollx', 05:39:49 INFO - 'cart']}, 05:39:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tsvgx', 05:39:49 INFO - 'tsvgr_opacity', 05:39:49 INFO - 'tart', 05:39:49 INFO - 'tscrollx', 05:39:49 INFO - 'cart']}, 05:39:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'tests': ['tp5o']}, 05:39:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s'], 05:39:49 INFO - 'tests': ['tp5o']}, 05:39:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--xperf_path', 05:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:49 INFO - 'tests': ['tp5n']}, 05:39:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:49 INFO - 'talos_options': ['--e10s', 05:39:49 INFO - '--xperf_path', 05:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:49 INFO - 'tests': ['tp5n']}}, 05:39:49 INFO - 'talos.zip': {'path': '', 05:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:49 INFO - Running post-action listener: _resource_record_post_action 05:39:49 INFO - ##### 05:39:49 INFO - ##### Running create-virtualenv step. 05:39:49 INFO - ##### 05:39:49 INFO - Running pre-action listener: _resource_record_pre_action 05:39:49 INFO - Running main action method: create_virtualenv 05:39:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:39:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:49 INFO - Using real prefix '/usr' 05:39:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:39:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:51 INFO - Installing pip.................done. 05:39:51 INFO - Return code: 0 05:39:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:51 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 05:39:51 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 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:39:51 INFO - Cleaning up... 05:39:51 INFO - Return code: 0 05:39:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:51 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:51 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 05:39:51 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 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:52 INFO - Downloading/unpacking psutil>=0.7.1 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:39:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:53 INFO - Installing collected packages: psutil 05:39:53 INFO - Running setup.py install for psutil 05:39:53 INFO - building 'psutil._psutil_linux' extension 05:39:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:39:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:39:54 INFO - building 'psutil._psutil_posix' extension 05:39:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:39:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:54 INFO - Successfully installed psutil 05:39:54 INFO - Cleaning up... 05:39:54 INFO - Return code: 0 05:39:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:39: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')]} 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', '--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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:54 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 05:39:54 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 05:39:54 INFO - Using env: {'DISPLAY': ':0', 05:39:54 INFO - 'HOME': '/home/cltbld', 05:39:54 INFO - 'LANG': 'en_US.UTF-8', 05:39:54 INFO - 'LANGUAGE': 'en_US:en', 05:39:54 INFO - 'LOGNAME': 'cltbld', 05:39:54 INFO - 'MAIL': '/var/mail/cltbld', 05:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:54 INFO - 'MOZ_NO_REMOTE': '1', 05:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:54 INFO - 'NO_EM_RESTART': '1', 05:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:54 INFO - 'SHELL': '/bin/bash', 05:39:54 INFO - 'SHLVL': '1', 05:39:54 INFO - 'TERM': 'linux', 05:39:54 INFO - 'TMOUT': '86400', 05:39:54 INFO - 'USER': 'cltbld', 05:39:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:54 INFO - '_': '/tools/buildbot/bin/python'} 05:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:39:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:39:56 INFO - Installing collected packages: mozsystemmonitor 05:39:56 INFO - Running setup.py install for mozsystemmonitor 05:39:56 INFO - Successfully installed mozsystemmonitor 05:39:56 INFO - Cleaning up... 05:39:56 INFO - Return code: 0 05:39:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:56 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:56 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 05:39:56 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 05:39:56 INFO - Using env: {'DISPLAY': ':0', 05:39:56 INFO - 'HOME': '/home/cltbld', 05:39:56 INFO - 'LANG': 'en_US.UTF-8', 05:39:56 INFO - 'LANGUAGE': 'en_US:en', 05:39:56 INFO - 'LOGNAME': 'cltbld', 05:39:56 INFO - 'MAIL': '/var/mail/cltbld', 05:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:56 INFO - 'MOZ_NO_REMOTE': '1', 05:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:56 INFO - 'NO_EM_RESTART': '1', 05:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:56 INFO - 'SHELL': '/bin/bash', 05:39:56 INFO - 'SHLVL': '1', 05:39:56 INFO - 'TERM': 'linux', 05:39:56 INFO - 'TMOUT': '86400', 05:39:56 INFO - 'USER': 'cltbld', 05:39:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:56 INFO - '_': '/tools/buildbot/bin/python'} 05:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:39:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:59 INFO - Downloading docopt-0.6.1.tar.gz 05:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:59 INFO - Running setup.py install for blobuploader 05:39:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:39:59 INFO - Running setup.py install for requests 05:40:00 INFO - Running setup.py install for docopt 05:40:00 INFO - Successfully installed blobuploader requests docopt 05:40:00 INFO - Cleaning up... 05:40:00 INFO - Return code: 0 05:40:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:00 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:00 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 05:40:00 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 05:40:00 INFO - Using env: {'DISPLAY': ':0', 05:40:00 INFO - 'HOME': '/home/cltbld', 05:40:00 INFO - 'LANG': 'en_US.UTF-8', 05:40:00 INFO - 'LANGUAGE': 'en_US:en', 05:40:00 INFO - 'LOGNAME': 'cltbld', 05:40:00 INFO - 'MAIL': '/var/mail/cltbld', 05:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:00 INFO - 'MOZ_NO_REMOTE': '1', 05:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:00 INFO - 'NO_EM_RESTART': '1', 05:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:00 INFO - 'SHELL': '/bin/bash', 05:40:00 INFO - 'SHLVL': '1', 05:40:00 INFO - 'TERM': 'linux', 05:40:00 INFO - 'TMOUT': '86400', 05:40:00 INFO - 'USER': 'cltbld', 05:40:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:00 INFO - '_': '/tools/buildbot/bin/python'} 05:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:00 INFO - Running setup.py (path:/tmp/pip-3yhy1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:00 INFO - Running setup.py (path:/tmp/pip-itU8Os-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:00 INFO - Running setup.py (path:/tmp/pip-zWDKrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:00 INFO - Running setup.py (path:/tmp/pip-ubbhiw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:00 INFO - Running setup.py (path:/tmp/pip-NPv_63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:00 INFO - Running setup.py (path:/tmp/pip-656HFH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:00 INFO - Running setup.py (path:/tmp/pip-FIEWHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:00 INFO - Running setup.py (path:/tmp/pip-I6jt5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:00 INFO - Running setup.py (path:/tmp/pip-ZQwR7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:01 INFO - Running setup.py (path:/tmp/pip-yxbd33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:01 INFO - Running setup.py (path:/tmp/pip-zl7aqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:01 INFO - Running setup.py (path:/tmp/pip-BBBaRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:01 INFO - Running setup.py (path:/tmp/pip-webzbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:01 INFO - Running setup.py (path:/tmp/pip-Zma3K2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:01 INFO - Running setup.py (path:/tmp/pip-OG6S86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:01 INFO - Running setup.py (path:/tmp/pip-9muARX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:01 INFO - Running setup.py (path:/tmp/pip-w2w4A0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:01 INFO - Running setup.py install for manifestparser 05:40:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:40:01 INFO - Running setup.py install for mozcrash 05:40:01 INFO - Running setup.py install for mozdebug 05:40:01 INFO - Running setup.py install for mozdevice 05:40:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozfile 05:40:02 INFO - Running setup.py install for mozhttpd 05:40:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozinfo 05:40:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozInstall 05:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozleak 05:40:02 INFO - Running setup.py install for mozlog 05:40:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for moznetwork 05:40:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozprocess 05:40:02 INFO - Running setup.py install for mozprofile 05:40:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:40:02 INFO - Running setup.py install for mozrunner 05:40:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Running setup.py install for mozscreenshot 05:40:03 INFO - Running setup.py install for moztest 05:40:03 INFO - Running setup.py install for mozversion 05:40:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:03 INFO - Cleaning up... 05:40:03 INFO - Return code: 0 05:40:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:03 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:03 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 05:40:03 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 05:40:03 INFO - Using env: {'DISPLAY': ':0', 05:40:03 INFO - 'HOME': '/home/cltbld', 05:40:03 INFO - 'LANG': 'en_US.UTF-8', 05:40:03 INFO - 'LANGUAGE': 'en_US:en', 05:40:03 INFO - 'LOGNAME': 'cltbld', 05:40:03 INFO - 'MAIL': '/var/mail/cltbld', 05:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:03 INFO - 'MOZ_NO_REMOTE': '1', 05:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:03 INFO - 'NO_EM_RESTART': '1', 05:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:03 INFO - 'SHELL': '/bin/bash', 05:40:03 INFO - 'SHLVL': '1', 05:40:03 INFO - 'TERM': 'linux', 05:40:03 INFO - 'TMOUT': '86400', 05:40:03 INFO - 'USER': 'cltbld', 05:40:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:03 INFO - '_': '/tools/buildbot/bin/python'} 05:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:03 INFO - Running setup.py (path:/tmp/pip-_v9wcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:03 INFO - Running setup.py (path:/tmp/pip-0952Kk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:03 INFO - Running setup.py (path:/tmp/pip-MMC8_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:03 INFO - Running setup.py (path:/tmp/pip-Vs4scG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:03 INFO - Running setup.py (path:/tmp/pip-DRV2oA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:04 INFO - Running setup.py (path:/tmp/pip-uFmVob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:04 INFO - Running setup.py (path:/tmp/pip-HUYLw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:04 INFO - Running setup.py (path:/tmp/pip-tyGV4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:04 INFO - Running setup.py (path:/tmp/pip-KbbXIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:04 INFO - Running setup.py (path:/tmp/pip-1kmNHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:04 INFO - Running setup.py (path:/tmp/pip-QQJT7u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:04 INFO - Running setup.py (path:/tmp/pip-aBOK_S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:04 INFO - Running setup.py (path:/tmp/pip-Ar26Az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:04 INFO - Running setup.py (path:/tmp/pip-oQHZfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:04 INFO - Running setup.py (path:/tmp/pip-NjgcCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:04 INFO - Running setup.py (path:/tmp/pip-lek2zV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:04 INFO - Running setup.py (path:/tmp/pip-Q8dwCX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:06 INFO - Downloading blessings-1.5.1.tar.gz 05:40:06 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 05:40:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:06 INFO - Installing collected packages: blessings 05:40:06 INFO - Running setup.py install for blessings 05:40:06 INFO - Successfully installed blessings 05:40:06 INFO - Cleaning up... 05:40:06 INFO - Return code: 0 05:40:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:40:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:07 INFO - Reading from file tmpfile_stdout 05:40:07 INFO - Current package versions: 05:40:07 INFO - argparse == 1.2.1 05:40:07 INFO - blessings == 1.5.1 05:40:07 INFO - blobuploader == 1.2.4 05:40:07 INFO - docopt == 0.6.1 05:40:07 INFO - manifestparser == 1.1 05:40:07 INFO - mozInstall == 1.12 05:40:07 INFO - mozcrash == 0.16 05:40:07 INFO - mozdebug == 0.1 05:40:07 INFO - mozdevice == 0.48 05:40:07 INFO - mozfile == 1.2 05:40:07 INFO - mozhttpd == 0.7 05:40:07 INFO - mozinfo == 0.9 05:40:07 INFO - mozleak == 0.1 05:40:07 INFO - mozlog == 3.1 05:40:07 INFO - moznetwork == 0.27 05:40:07 INFO - mozprocess == 0.22 05:40:07 INFO - mozprofile == 0.28 05:40:07 INFO - mozrunner == 6.11 05:40:07 INFO - mozscreenshot == 0.1 05:40:07 INFO - mozsystemmonitor == 0.0 05:40:07 INFO - moztest == 0.7 05:40:07 INFO - mozversion == 1.4 05:40:07 INFO - psutil == 3.1.1 05:40:07 INFO - requests == 1.2.3 05:40:07 INFO - wsgiref == 0.1.2 05:40:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:07 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 05:40:07 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 05:40:07 INFO - Using env: {'DISPLAY': ':0', 05:40:07 INFO - 'HOME': '/home/cltbld', 05:40:07 INFO - 'LANG': 'en_US.UTF-8', 05:40:07 INFO - 'LANGUAGE': 'en_US:en', 05:40:07 INFO - 'LOGNAME': 'cltbld', 05:40:07 INFO - 'MAIL': '/var/mail/cltbld', 05:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:07 INFO - 'MOZ_NO_REMOTE': '1', 05:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:07 INFO - 'NO_EM_RESTART': '1', 05:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:07 INFO - 'SHELL': '/bin/bash', 05:40:07 INFO - 'SHLVL': '1', 05:40:07 INFO - 'TERM': 'linux', 05:40:07 INFO - 'TMOUT': '86400', 05:40:07 INFO - 'USER': 'cltbld', 05:40:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:07 INFO - '_': '/tools/buildbot/bin/python'} 05:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:40:07 INFO - Cleaning up... 05:40:07 INFO - Return code: 0 05:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:07 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:07 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 05:40:07 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 05:40:07 INFO - Using env: {'DISPLAY': ':0', 05:40:07 INFO - 'HOME': '/home/cltbld', 05:40:07 INFO - 'LANG': 'en_US.UTF-8', 05:40:07 INFO - 'LANGUAGE': 'en_US:en', 05:40:07 INFO - 'LOGNAME': 'cltbld', 05:40:07 INFO - 'MAIL': '/var/mail/cltbld', 05:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:07 INFO - 'MOZ_NO_REMOTE': '1', 05:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:07 INFO - 'NO_EM_RESTART': '1', 05:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:07 INFO - 'SHELL': '/bin/bash', 05:40:07 INFO - 'SHLVL': '1', 05:40:07 INFO - 'TERM': 'linux', 05:40:07 INFO - 'TMOUT': '86400', 05:40:07 INFO - 'USER': 'cltbld', 05:40:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:07 INFO - '_': '/tools/buildbot/bin/python'} 05:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:07 INFO - Downloading/unpacking jsonschema 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:09 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 05:40:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:40:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:09 INFO - warning: no files found matching '*.txt' 05:40:09 INFO - no previously-included directories found matching 'build' 05:40:09 INFO - no previously-included directories found matching 'dist' 05:40:09 INFO - no previously-included directories found matching '.git*' 05:40:09 INFO - Installing collected packages: jsonschema, functools32 05:40:09 INFO - Running setup.py install for functools32 05:40:09 INFO - warning: no files found matching '*.txt' 05:40:09 INFO - no previously-included directories found matching 'build' 05:40:09 INFO - no previously-included directories found matching 'dist' 05:40:09 INFO - no previously-included directories found matching '.git*' 05:40:09 INFO - Successfully installed jsonschema functools32 05:40:09 INFO - Cleaning up... 05:40:09 INFO - Return code: 0 05:40:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 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 0x7fcc4a167f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:09 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 05:40:09 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 05:40:09 INFO - Using env: {'DISPLAY': ':0', 05:40:09 INFO - 'HOME': '/home/cltbld', 05:40:09 INFO - 'LANG': 'en_US.UTF-8', 05:40:09 INFO - 'LANGUAGE': 'en_US:en', 05:40:09 INFO - 'LOGNAME': 'cltbld', 05:40:09 INFO - 'MAIL': '/var/mail/cltbld', 05:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:09 INFO - 'MOZ_NO_REMOTE': '1', 05:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:09 INFO - 'NO_EM_RESTART': '1', 05:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:09 INFO - 'SHELL': '/bin/bash', 05:40:09 INFO - 'SHLVL': '1', 05:40:09 INFO - 'TERM': 'linux', 05:40:09 INFO - 'TMOUT': '86400', 05:40:09 INFO - 'USER': 'cltbld', 05:40:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:09 INFO - '_': '/tools/buildbot/bin/python'} 05:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:10 INFO - Downloading/unpacking flake8 05:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:11 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 05:40:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:11 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 05:40:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:12 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 05:40:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:40:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:12 INFO - no previously-included directories found matching 'docs/_build' 05:40:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:12 INFO - Running setup.py install for pep8 05:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:12 INFO - no previously-included directories found matching 'docs/_build' 05:40:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:40:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:12 INFO - Cleaning up... 05:40:12 INFO - Return code: 0 05:40:12 INFO - Running post-action listener: _resource_record_post_action 05:40:12 INFO - Running post-action listener: _start_resource_monitoring 05:40:12 INFO - Starting resource monitoring. 05:40:12 INFO - ##### 05:40:12 INFO - ##### Running install step. 05:40:12 INFO - ##### 05:40:12 INFO - Running pre-action listener: _resource_record_pre_action 05:40:12 INFO - Running main action method: install 05:40:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:12 INFO - Reading from file tmpfile_stdout 05:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:40:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:40:12 INFO - Reading from file tmpfile_stdout 05:40:12 INFO - Output received: 05:40:12 INFO - Usage: mozinstall [options] installer 05:40:12 INFO - Options: 05:40:12 INFO - -h, --help show this help message and exit 05:40:12 INFO - -d DEST, --destination=DEST 05:40:12 INFO - Directory to install application into. [default: 05:40:12 INFO - "/builds/slave/test-pgo"] 05:40:12 INFO - --app=APP Application being installed. [default: firefox] 05:40:12 INFO - mkdir: /builds/slave/test-pgo/build/application 05:40:12 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'] 05:40:12 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 05:40:28 INFO - Reading from file tmpfile_stdout 05:40:28 INFO - Output received: 05:40:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:40:28 INFO - Running post-action listener: _resource_record_post_action 05:40:28 INFO - ##### 05:40:28 INFO - ##### Running run-tests step. 05:40:28 INFO - ##### 05:40:28 INFO - Running pre-action listener: _resource_record_pre_action 05:40:28 INFO - Running main action method: run_tests 05:40:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:40:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:40:28 INFO - Python 2.7.3 05:40:28 INFO - Return code: 0 05:40:28 INFO - grabbing minidump binary from tooltool 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:28 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 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:40:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:40:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:29 INFO - Return code: 0 05:40:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:40:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:40:29 INFO - Return code: 0 05:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:40:29 INFO - Using env: {'DISPLAY': ':0', 05:40:29 INFO - 'HOME': '/home/cltbld', 05:40:29 INFO - 'LANG': 'en_US.UTF-8', 05:40:29 INFO - 'LANGUAGE': 'en_US:en', 05:40:29 INFO - 'LOGNAME': 'cltbld', 05:40:29 INFO - 'MAIL': '/var/mail/cltbld', 05:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:29 INFO - 'MOZ_NO_REMOTE': '1', 05:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:29 INFO - 'NO_EM_RESTART': '1', 05:40:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:40:29 INFO - 'SHELL': '/bin/bash', 05:40:29 INFO - 'SHLVL': '1', 05:40:29 INFO - 'TERM': 'linux', 05:40:29 INFO - 'TMOUT': '86400', 05:40:29 INFO - 'USER': 'cltbld', 05:40:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597', 05:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:29 INFO - '_': '/tools/buildbot/bin/python'} 05:40:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:40:30 INFO - mozversion application_buildid: 20160116030240 05:40:30 INFO - mozversion application_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 05:40:30 INFO - mozversion application_display_name: Nightly 05:40:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:30 INFO - mozversion application_name: Firefox 05:40:30 INFO - mozversion application_remotingname: firefox 05:40:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:30 INFO - mozversion application_vendor: Mozilla 05:40:30 INFO - mozversion application_version: 46.0a1 05:40:30 INFO - mozversion platform_buildid: 20160116030240 05:40:30 INFO - mozversion platform_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 05:40:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:30 INFO - mozversion platform_version: 46.0a1 05:40:30 INFO - using testdate: 1452951630 05:40:30 INFO - actual date: 1452951630 05:40:30 INFO - starting webserver on 'localhost:54564' 05:40:30 INFO - SUITE-START | Running 3 tests 05:40:30 INFO - TEST-START | dromaeo_css 05:40:30 INFO - operating with platform_type : linux_ 05:40:30 INFO - Initialising browser for dromaeo_css test... 05:40:30 INFO - TEST-INFO | started process 27212 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaR6H_q/profile http://localhost:54564/getInfo.html) 05:40:34 INFO - PROCESS | 27212 | __metrics Screen width/height:1600/1200 05:40:34 INFO - PROCESS | 27212 | colorDepth:24 05:40:34 INFO - PROCESS | 27212 | Browser inner width/height: 1024/697 05:40:34 INFO - PROCESS | 27212 | __metrics 05:40:34 INFO - PROCESS | 27212 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:40:34 INFO - PROCESS | 27212 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:35 INFO - TEST-INFO | 27212: exit 0 05:40:35 INFO - Browser initialized. 05:40:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:35 INFO - TEST-INFO | started process 27306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaR6H_q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:47 INFO - PROCESS | 27306 | RSS: Main: 150130688 05:40:47 INFO - PROCESS | 27306 | 05:41:39 INFO - PROCESS | 27306 | 1452951699293 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:43:47 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54564/tests/dromaeo/cssquery-ext.html) 05:43:48 INFO - PROCESS | 27306 | RSS: Main: 241790976 05:43:48 INFO - PROCESS | 27306 | 05:46:50 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-ext.html (next: http://localhost:54564/tests/dromaeo/cssquery-jquery.html) 05:46:51 INFO - PROCESS | 27306 | RSS: Main: 228769792 05:46:51 INFO - PROCESS | 27306 | 05:49:53 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54564/tests/dromaeo/cssquery-mootools.html) 05:49:54 INFO - PROCESS | 27306 | RSS: Main: 223264768 05:49:54 INFO - PROCESS | 27306 | 05:52:56 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54564/tests/dromaeo/cssquery-prototype.html) 05:52:56 INFO - PROCESS | 27306 | RSS: Main: 210591744 05:52:56 INFO - PROCESS | 27306 | 05:55:59 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54564/tests/dromaeo/cssquery-yui.html) 05:55:59 INFO - PROCESS | 27306 | RSS: Main: 211316736 05:55:59 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | Cycle 1(1): loaded http://localhost:54564/tests/dromaeo/cssquery-yui.html (next: http://localhost:54564/tests/dromaeo/cssquery-dojo.html) 05:59:02 INFO - PROCESS | 27306 | RSS: Main: 228155392 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | __start_tp_report 05:59:02 INFO - PROCESS | 27306 | _x_x_mozilla_page_load 05:59:02 INFO - PROCESS | 27306 | _x_x_mozilla_page_load_details 05:59:02 INFO - PROCESS | 27306 | |i|pagename|runs| 05:59:02 INFO - PROCESS | 27306 | |0;dojo.html;3162.193640621642;3183.5065564837446;3217.099212220579;3238.125706059365;3254.235254715143;5034.899302013958;5150.587952963763;5182.896342073156;5188.325517682696;5193.350831146102;5196.92204616931;5209.557187639046;5236.528712415882;5247.632665713401;5253.264542963988;4732.550407711271;4767.1419144553965;4775.71345719258;4814.470408255107;4830.661853670244;4752.287156926454;4752.906831428773;4762.928556071662;4797.7121372717575;4804.37543119394;4605.562471565196;4705.294205869112;4736.573708366229;4822.348982887301;4829.203181475053;4746.240601503778;4769.117713223065;4773.260144677581;4784.904301913977;4812.205986012304;4630.073985202973;4747.287906813971;4747.715137091751;4770.236762118045;4799.544043315879;4903.387076615423;4939.925901111486;4955.0833095877015;4962.627802914796;4994.275830004665;5601.29983752031;5612.326520817487;5625.746841392147;5628.465295796893;5633.943660563383;5498.092814685612;5604.299462567179;5646.096624540095;5658.547316214693;5660.349059858087;5210.609204309692;5269.473052694738;5287.127623942045;5290.470952904756;5330.946690533084;5768.4808367246305;5769.249997500298;5770.88458230833;5777.711114444261;5782.508486778671;5380.973095134577;5474.534664553478;5477.315335583052;5539.25220095282;5549.056660367747;5526.143447765603;5609.971950140223;5617.157426385993;5618.157276408571;5663.405342439067;5466.753996070107;5483.616146869761;5486.506214440719;5497.917531237034;5500.42245564218;5352.705601191894;5461.918071228934;5482.533984611353;5502.58730595207;5530.446955304437;4327.2643650579475;4341.804618792162;4342.652587792969;4370.191514569751;4378.737275763465;3880.068783491998;3889.922201555953;3890.9494436501986;3921.0197450637343;3925.6270654287796;5018.899622007612;5094.2103973884105;5155.561777248976;5178.508041736029;5243.68537887728;5568.220449137124;5571.860703482364;5578.693171875505;5597.216389705444;5598.10430331145;5187.559057480081;5196.714180720021;5201.661891977009;5202.323697919322;5248.527632513016;4659.767011649404;4735.1240020595615;4740.288956656529;4783.995360974165;4822.469528351879;5772.913406298909;5824.563157763185;5827.533797296291;5828.59199856006;5836.2412886325355;5452.400235974119;5624.690642014565;5635.520980716521;5653;5700.287464066992;5618.69097199658;5761.251037365116;5795.565332600157;5814.069748840166;5854.648721076749;5481.150421684645;5493.587980901369;5497.092979658471;5500.724963751716;5504.972475137599;5377.193420986883;5492.093804522209;5564.221009058654;5566.304211973504;5570.972145139248;5404.783808647768;5442.972785136049;5447.700376479332;5455.208994695826;5487.094629386266;5309.628326017141;5319.867003324793;5320.2817619620855;5330.413654497925;5371.40914499397;5190.09173394662;5218.321618189611;5244.239585260192;5269.420363759907;5301.787928482818;5390.407055223844;5435.076037073786;5442.673439593637;5466.2620546227345;5491.983982963165;5332.466753324792;5332.733363331896;5336.2529245904825;5338.3060202173465;5343.225232341367 05:59:02 INFO - PROCESS | 27306 | |1;ext.html;492.33288893549263;546.1643685161703;565.5164834066871;577.416809022887;596.94341016401;27566.31084222893;27711.445771084593;27763.444731105366;28070.71929280709;35743.64256357442;38868.22263554734;38936.610633893724;39170.412443813366;39172.60827391725;39310.479294881094;8338.45800022998;8514.446560973547;8547.871781923277;8557.443766155211;8598.656053757843;8281.875771863426;8355.456895301817;8418.915810841874;8420.621072051741;8430.072692003905;8398.45410048348;8640.135986401341;8683.34874884383;8686.174813392718;8687.782805429852;8579.313654907592;8635.309175265964;8653.956730216372;8658.696945606936;8664.090270521567;8425.831483370299;8649.437786543918;8651.956740216321;8660.913390866137;8663.306935445149;39267.60732392697;39689.60310396888;39712.20575588472;39760.60239397627;39764;3486;3504;3511.10466830959;3672.908177295589;3948.5853985331414;29718.70281297181;29843.813215190177;30146;30530.84734576313;31178.688213117806;3722.4416337549314;3743.5320584926885;3745.4569087482164;3830.9425358619364;3866.4780254665543;245767;246587;247105;247219;248761;51855.740721296905;52748.472515274356;57474.7126264366;60074.09888851671;60567.39432605617;59688;59782.402175978554;59913.40086599165;60090;60099.39900601025;15740;15918.9204053979;15923.442679506394;15948.920255398649;15972;10958.780824383468;11223.270487418291;11444.484998175101;11745.29528228309;11759.706007349714;19197.90401048014;19277.325293614656;20017.526040110708;20057.29799457012;20091.497712557302;7666.3866890648615;7680.270374314431;7737.110232323243;7810.765677029584;7831.569263690551;886.4946980221212;946.9337146399823;1030.8866024737272;1031.3811712972156;1074.3607553505651;28188.577171342447;28668.80233126756;28760.424791504054;28971.13086607363;29068.418631627672;1031.7721910925975;1097.9560817567367;1106.435717783936;1167.422126047595;1203.0676225924979;15041.57105075016;15097.169655669044;15423.845761542465;15529.689406211812;15796.289166987513;263267;263764;264611;264928;266141;48360;48521.75739121282;48672.75663621659;48738;48840.7557962215;1320.3530270167741;1329.8271224740915;1347.5553067487706;1349.5006847466304;1349.9548184500686;25429;28183.154505364873;28634.570481442377;29670.554941676324;30281.69718302877;45331.54668453273;45664.54335456603;45666.08667826691;45684.543154568026;45729.771351143034;199385;201263;201689;201718;202016;27293.454130917667;27941.30146746266;30905.845470772503;30950;32007.359852803278;37381.43927841139;37450.81274593718;37743.433848491746;37855.242895142495;38467;32364.35271294608;32431.513527297582;32615.18462038468;32723.836380817942;33109.83445082759;34498.655013450545;34656;34694;34807.651923480444;34902.30195396129;32403.18992025124;32627.34745305033;32977.51601177905;33025.174370640925;33222.5016624746;29102.70897291;30220.84889575538;31234.375312494078;31671.84164079165;31672.208194795316;24521.386965326008;24757.381065473506;24813.751862481866;25066.498670026864;25189 05:59:02 INFO - PROCESS | 27306 | |2;jquery.html;369.13806262377346;369.29464722380243;369.75411351451277;372.2573465935459;377.18339794345246;13523.864761352383;13627.727445451084;15523.456679016237;16720.498385048453;17654.205560749764;15352.84647153531;15503.147326897017;15600.375984960616;15656.217189140554;16172.35310587575;5261.394939581949;5465.453454654543;5466.562674985991;5469;5473.425290344516;3999.800009999503;4117.670586353084;5339.6262261641705;5636.971815140919;5837.766489340422;5630.915536266959;5792.4497172768515;5829.387914268983;5845.357010728816;5927.02204136317;5889.8822023559715;5922.378150294222;5927.199828023205;5931.377205393458;5957.940420595782;5130.51260130287;5220.73896305187;5301.363836339626;5315.521603055705;5321.148616221425;19267;19677.114529846047;19780.90109549443;19952.80047199524;20362.490937726674;663.5819433756702;1404.473322504061;1565.5616427400346;2308.9307320780404;2521.8108641851936;12463.12758106933;12609.30648814315;12686.619401417973;12845.67885802853;13115;1826.5981484073482;1834.385480863912;1875.559243577758;1887.282832523646;1906.20892329683;51024.744876275756;51624.22563661548;52039.479605203844;52696.20955685668;52747.736261318445;9491.66779162726;9640.566174522164;9811.411315321104;9829.754256143653;9917;12698.031805070228;12849.935750321376;12850.228986260854;12853.357332133355;12864.16382935125;7391.630418479054;7464.365528929993;7626.656800443993;7685.346745526581;7701.884471732928;7298;7301.342879140902;7370.852582948311;7377.151627562792;7419.258074192538;5206.817761378334;5847.415258474203;5863.384344643751;5874.412558744091;5885.793997210163;1716.2448522649995;1743.8953662780273;1782.2603619497763;1794.4078454110374;1795.7845058593052;426.8591364849592;433.8481531463962;437.26321148864264;440.60345688879625;992.533509250651;9257.629694812267;10679.359238445719;10859.13126949842;10949.397783122005;11258.155638327158;444.4533224134333;448.0456627383652;450.9582863585129;462.77555385637936;475.25622400942416;5877.941220587825;5936.198613187251;6227.750889964351;6247.500199983991;6312.621242725451;558448;558821;559257;568524;571936;64016.67991660105;67770;68764;68883;69911;1004.2869562610629;1034.3225187502198;1071.5071067309125;1103.6192513582962;1114.5374669512062;14087.647808804863;14204.928975355057;14646.70706585841;15137.318820653318;15429.537113886601;29418.264543386587;29956.550651739806;30355.544666830458;31086.533701994034;31404.528932066496;37092.81453592715;39135.80432097821;41248.38127428031;41308.58691413047;41345.379819303336;7055.541389809646;7370.852582948418;7505.437092218214;7577.393808495197;7608.01095857535;10506.789864202827;10689.9465502672;10836.891631083588;11256.718582035515;11592.942035289769;9063.546822658973;9295.977442481457;9325.160735533835;9632.325737198329;9647;9082.772930676785;9134.26925845944;9150.725478235663;9455.14903658674;9484.668036618685;9420.152186303265;9726.659566915125;9782.364146330467;10199.54102065394;10533.26267161322;7506.099268087864;7514.098308202832;7586.772396828104;7624.27569380908;7640.732574360093;9022.954885225532;9238.676646317346;9825.95087024589;9920.966201928442;9963.103320700882 05:59:02 INFO - PROCESS | 27306 | |3;mootools.html;1267.8161666558344;1452.7457694903392;1482.3625840888417;1655.8178600353958;1821.225978958942;6681.432078273347;7698.191689872559;7826.943362646041;7846.136924938267;7865.882011769813;7675.846483070335;7833.764987050384;7834.2949134577875;7835.020622422197;7857.882131768014;2047.4471892588992;2087.8956052197404;2306.942326441844;2308.3882771065637;2331.976680233193;2345.8827058647084;2351.6590094436297;2355.7290911545133;2355.9411014724683;2357.49313897512;2282.942926426836;2348.131191459154;2352.047420794581;2353.0940587873706;2353.188150088217;2321.779430954057;2349.859008459498;2378.63131214662;2378.9167379141645;2380.8095352371943;2349.189529612281;2355.2463211772238;2384.070212617081;2385.5705972924866;2386.5942789725786;7954.085280192794;8003.359731221488;8004;8004.759857204293;8008.239217274349;4805.687630304054;4866.124097662419;4873.756312184377;4873.878153046202;4910.263460480956;3101.7673674474504;3166.319241363095;3216.292415668549;3224.3551289742145;3224.790388624732;969.3892847506097;985.5614251658016;1030.1398332392462;1032.7211652853762;1061.2518174686827;10483.895161048367;10514.842277365846;10520.263581549294;10525.36847789135;10532.26274160809;4459.996500787362;4473.329000649864;4521.8191272349395;4568.931466028012;4595.058013107305;8635.352348573882;8673.696420625249;8772.38593298463;8776.736697899074;8783.604737786814;4841.443234028062;4879.682820616648;4894.486078961658;4896.608271338356;4931.876703082452;4449.243628583149;4493.865184044484;4498.032922921588;4502.5047244803045;4504.684672072989;3334.1164591383304;3390.9491357629654;3652.671259586597;3654.780713157219;3732.0296722852254;1169.8771628978834;1199.8500187476566;1200.5317926008863;1200.5857978997233;1209.371127013948;1295.3846922711637;1319.0766463475607;1336.6591519162746;1364.6861221918816;1369.1511263016794;7247.13034435871;7391;7395.075615548057;7398.704051837866;7406.07424071991;1113.6881673131536;1119.1885882735114;1125.2348403085816;1126.5381193710539;1134.4044376702298;5808.709564521757;5849.239598852207;5885.470307672244;5885.793997210077;5886.882262354815;9048.592813323416;9192.81614367709;9230.123138301851;9388.34281600295;9427.434353938786;9224.354295199271;9257.768555786024;9268.629254829732;9270;9271.211946984447;7165.104361954755;7235.638218089074;7297.379722723628;7399.149097853708;7404.888926666212;7366.300201480851;7386.15059268191;7437.851242975002;7444.516106453063;7452.403807695479;8477.533735644352;8477.703280385156;8610.698625548326;8752.69365572202;8756.78108047304;8581.27059199975;8983.505907175168;8988.86516702263;8994.59524321394;9000.729978100668;6072.392760723892;6829.043933849364;6878.27778083314;6892.207396149507;6893.827654308482;6731.293214212437;7116.964415177891;7297.379722723415;7298.4891057625455;7301.634918254173;6935.271796461299;7122.964385178041;7131.0729605151;7173.748918787817;7256.673449694671;6931.861362772615;6934.930650693428;7006.544574602634;7113.359797618239;7148.070750802362;6846.691898864663;6847.554908930903;6883.518153729191;6895.448364130958;7074.858502829811;6489.091527186292;6513.4463570595135;6521;6533.705983230671;6537.542372033912;6570.5400621957915;6589.4069533742195;6602.8349291268105;6604.042413849868;6611.239707433707 05:59:02 INFO - PROCESS | 27306 | |4;prototype.html;338.29971958046855;339.50969637707414;342.82344592534844;345.9636738142495;352.40443650231117;5737.885242295151;5840.0947853082735;5875.385453473206;5941.346451890288;5997.700114994243;5654.434556544344;5775.913361299584;5784.219130417392;5787.47912687858;5798.681072541009;4587.38070360502;4593.678442509034;4595.517470665583;4596.862094137181;4598.195315819735;4357.433533640622;4456.910861782762;4501.189785838547;4571.542845715435;4601.125786100647;4490.57339552742;4507.09858028394;4518.209313370164;4519.706219095765;4528.615067719232;4517.796699148546;4519.457665080195;4525.615322697558;4533.229351010336;4562.703424277444;4046.9190616187807;4051.027753339207;4057.675385969145;4059.533153687334;4060.5736397678115;5458.972705136489;5607.635503692247;5609.411011843738;5643.774249030034;5648.971755141198;5198.792048318062;5211.296474975868;5216.113260745682;5219.373675159005;5221.608379371524;5952.077427998667;6241.375862413768;6251.843703907393;6253.374662533755;6257.374262573751;4262.041040765834;4295.055087880662;4326.351047342892;4326.437563116806;4331.848385306499;6300.716467758962;6509.2839787623325;6522.4782017438965;6551.574147680385;6577.144971153767;4394.209042372404;4398.3842262083335;4398.868033958986;4399.670024748157;4403;4341.45731783527;4412.294032954712;4443.755593442327;4447.644188464915;4456.442944631921;5132.794688212504;5148.768305426265;5156.845294641092;5168.095583272988;5168.870778230499;6215.502759779207;6245.437910588069;6257.186565746515;6257.8748425031245;6264.968675156686;1586.0483709774273;1610.3478091373013;1611.1702473226298;1611.8307577704172;1614.2655091933143;1079.1097344690504;1080.7298175456135;1086.750047489082;1109.040679811973;1112.8998390144925;5912.852178695481;5920.2007728956905;5926.436988486087;5927.081302398135;5934.43622855828;6420.967895160495;6421.614703117734;6426.4216220540375;6427.164468619049;6435.227772667216;5897.144913987534;5912;5913.467787899023;5917.822465326047;5921.940780592225;3374.2407958209205;3493.825308734553;3496.5804103507744;3500.807455589916;3501.8774342897877;6713.56361836479;6718.260991290954;6723.865522689519;6727.192736871607;6733.629650369178;6677.165354330708;6687.832804179934;6687.866242675119;6696.966515167393;6697.464202863759;6522.119513865662;6668.266250774834;6703;6711.463082953352;6713.4964877634375;6255.218097737783;6356.618602883842;6489.772857949949;6494.935050649433;6496.480281577557;6244.937550624436;6298.937010630018;6347.873042539216;6407.8718425630295;6418.614883107029;6655.933440665725;6672.5329226953645;6682.9331706682315;6691.1636045494315;6696.0960270362875;4366.628836548929;4386.846460373999;4397.890052748707;4399.208142534247;4399.934000989923;6416.069669897932;6426.839329016812;6429.164208652845;6444.806655800334;6446;6240.656763878031;6243.063540468966;6244.219472565929;6249.437550620466;6251.9062214067735;6149.108379284889;6227.0970709246;6229.190205273286;6233.158523599256;6289.685515724104;6159.260888693386;6168.784092556739;6184.907226391518;6194.783182588768;6200.503959683305;6339.587926784744;6343.682815859096;6349.07938348946;6349.746010159727;6351.777687780906;6075.787347442818;6169.598976066542;6170.290416602148;6184.041473571604;6187.412195841388 05:59:02 INFO - PROCESS | 27306 | |5;yui.html;717.4977515738984;734.599643194459;782.000069643772;815.7593509914578;834.3367023216542;12906.870931290685;13029.804552931713;13037.934810325947;13053.804192937114;13064.73870522589;12251.20367176133;12465.252084874914;12595.118341716083;12686.429110690018;12727.745445091092;654.2933631677777;659.1036190780559;793.3256731777972;803.7186984555417;804.8551260773058;789.17925357628;798.9960050199741;804.4127786715701;805.3919290935365;806.6249194124731;847.1951645936385;847.2120927537388;847.504210037129;847.8431490174306;848.4273115646945;690.8203866994593;699.5383047188831;700.1353328639152;828.0891019878086;844.2317491083115;614.8555089553952;615.5506480269429;615.6152404747033;616.5745635511482;617.1360095865779;12985.220886746825;13027.674308142277;13032.80450793239;13073.280969546671;13092.410841512155;11488.195826292163;11946.820797688042;11991.820122698167;12109.818352724717;12354.691132721753;9029.097090290918;9342.813143737087;9438.952805235998;9485.525723713787;9609.951950240275;3335.7164641005543;3356.647552007053;3413.7951722896705;3486.477028445728;3492.772969756983;44719;45046.549534504564;45057;45332.320015199795;46027.539724603;8982.416142950688;9083.091690830865;9202.125798049176;9284.535773211312;9307.53462326881;15003.549893503212;15147.697046059016;15161.924190378977;15189.392424303125;15227.314770835339;6821.484005018398;6841.213260475109;6895.5173137879865;6997.370236678622;7058.858822823515;3693.0951916780023;3698.204885949534;3725;3742.719296052807;3771.07608635886;3224.1617179533023;3226.435373809574;3244.4808830586994;3248.204189973472;3248.951265731016;601.6510423954184;610.5603965145089;610.6854969690613;613.7729040255045;615.1265203411167;478.50474758624654;507.3556583139392;562.8930503204379;586.9060950248025;610.0117809149207;8017.518948863087;8264.479333803247;8284.71003514886;8343.791405214919;8459.534725590152;488.7092180152803;493.75065591875875;581.6103210848742;582.967936763482;586.4487381861122;3734.2158146788934;3817;3994.6404823566018;4047.5952404759287;4180.1848639515;54280.45719542754;54325.45674543204;54905;55125;55332;48632.27051594229;50001.74999124981;50309.49690503048;50385;50623.74688126536;44162;44392.55607443949;45041;45238.77380613076;45473.772631136635;8180.959095204724;8216.137305582828;8219.589020548829;8320.875186872081;8330.750077497685;33004;33688.83155584305;33906.83046584751;34185.658143418244;34393.140171495914;40563;41607.167856643304;43475.78262108669;43565.78217108894;43684.78157609192;9482.099200575934;9624.855627165738;9655.517224138905;9677.419354838732;9773.07155820196;10201.004274886789;10418.322809017389;10437.58249670035;10451.425171615634;10453.843192352273;9807.313488055768;9854.162396196403;9858.55636496345;10126.898731012596;10154.289199755945;9827;9870.358426702242;10035.54840032215;10059.245556583432;10241.334313269614;7600.771976840703;10118.19054475655;10255.897441025494;10322.845157322796;10577.889321621427;8394.118617545315;8404;8404.474023485169;8523.82952340962;9059.592318345558;8678.392512524062;8937.551658550652;9051.54742262871;9084.091590841128;9099.090090990849 05:59:02 INFO - PROCESS | 27306 | __end_tp_report 05:59:02 INFO - PROCESS | 27306 | __start_cc_report 05:59:02 INFO - PROCESS | 27306 | _x_x_mozilla_cycle_collect,787 05:59:02 INFO - PROCESS | 27306 | __end_cc_report 05:59:02 INFO - PROCESS | 27306 | __startTimestamp1452952742597__endTimestamp 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | ------- Summary: start ------- 05:59:02 INFO - PROCESS | 27306 | Number of tests: 6 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#0] dojo.html Cycles:165 Average:5170.58 Median:5330.41 stddev:554.38 (10.4%) stddev-sans-first:533.22 05:59:02 INFO - PROCESS | 27306 | Values: 3162.2 3183.5 3217.1 3238.1 3254.2 5034.9 5150.6 5182.9 5188.3 5193.4 5196.9 5209.6 5236.5 5247.6 5253.3 4732.6 4767.1 4775.7 4814.5 4830.7 4752.3 4752.9 4762.9 4797.7 4804.4 4605.6 4705.3 4736.6 4822.3 4829.2 4746.2 4769.1 4773.3 4784.9 4812.2 4630.1 4747.3 4747.7 4770.2 4799.5 4903.4 4939.9 4955.1 4962.6 4994.3 5601.3 5612.3 5625.7 5628.5 5633.9 5498.1 5604.3 5646.1 5658.5 5660.3 5210.6 5269.5 5287.1 5290.5 5330.9 5768.5 5769.2 5770.9 5777.7 5782.5 5381.0 5474.5 5477.3 5539.3 5549.1 5526.1 5610.0 5617.2 5618.2 5663.4 5466.8 5483.6 5486.5 5497.9 5500.4 5352.7 5461.9 5482.5 5502.6 5530.4 4327.3 4341.8 4342.7 4370.2 4378.7 3880.1 3889.9 3890.9 3921.0 3925.6 5018.9 5094.2 5155.6 5178.5 5243.7 5568.2 5571.9 5578.7 5597.2 5598.1 5187.6 5196.7 5201.7 5202.3 5248.5 4659.8 4735.1 4740.3 4784.0 4822.5 5772.9 5824.6 5827.5 5828.6 5836.2 5452.4 5624.7 5635.5 5653.0 5700.3 5618.7 5761.3 5795.6 5814.1 5854.6 5481.2 5493.6 5497.1 5500.7 5505.0 5377.2 5492.1 5564.2 5566.3 5571.0 5404.8 5443.0 5447.7 5455.2 5487.1 5309.6 5319.9 5320.3 5330.4 5371.4 5190.1 5218.3 5244.2 5269.4 5301.8 5390.4 5435.1 5442.7 5466.3 5492.0 5332.5 5332.7 5336.3 5338.3 5343.2 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#1] ext.html Cycles:180 Average:40747.72 Median:33166.17 stddev:62137.93 (187.4%) stddev-sans-first:62238.72 05:59:02 INFO - PROCESS | 27306 | Values: 492.3 546.2 565.5 577.4 596.9 27566.3 27711.4 27763.4 28070.7 35743.6 38868.2 38936.6 39170.4 39172.6 39310.5 8338.5 8514.4 8547.9 8557.4 8598.7 8281.9 8355.5 8418.9 8420.6 8430.1 8398.5 8640.1 8683.3 8686.2 8687.8 8579.3 8635.3 8654.0 8658.7 8664.1 8425.8 8649.4 8652.0 8660.9 8663.3 39267.6 39689.6 39712.2 39760.6 39764.0 3486.0 3504.0 3511.1 3672.9 3948.6 29718.7 29843.8 30146.0 30530.8 31178.7 3722.4 3743.5 3745.5 3830.9 3866.5 245767.0 246587.0 247105.0 247219.0 248761.0 51855.7 52748.5 57474.7 60074.1 60567.4 59688.0 59782.4 59913.4 60090.0 60099.4 15740.0 15918.9 15923.4 15948.9 15972.0 10958.8 11223.3 11444.5 11745.3 11759.7 19197.9 19277.3 20017.5 20057.3 20091.5 7666.4 7680.3 7737.1 7810.8 7831.6 886.5 946.9 1030.9 1031.4 1074.4 28188.6 28668.8 28760.4 28971.1 29068.4 1031.8 1098.0 1106.4 1167.4 1203.1 15041.6 15097.2 15423.8 15529.7 15796.3 263267.0 263764.0 264611.0 264928.0 266141.0 48360.0 48521.8 48672.8 48738.0 48840.8 1320.4 1329.8 1347.6 1349.5 1350.0 25429.0 28183.2 28634.6 29670.6 30281.7 45331.5 45664.5 45666.1 45684.5 45729.8 199385.0 201263.0 201689.0 201718.0 202016.0 27293.5 27941.3 30905.8 30950.0 32007.4 37381.4 37450.8 37743.4 37855.2 38467.0 32364.4 32431.5 32615.2 32723.8 33109.8 34498.7 34656.0 34694.0 34807.7 34902.3 32403.2 32627.3 32977.5 33025.2 33222.5 29102.7 30220.8 31234.4 31671.8 31672.2 24521.4 24757.4 24813.8 25066.5 25189.0 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#2] jquery.html Cycles:180 Average:27537.54 Median:5213.78 stddev:91933.22 (1763.3%) stddev-sans-first:92168.48 05:59:02 INFO - PROCESS | 27306 | Values: 369.1 369.3 369.8 372.3 377.2 13523.9 13627.7 15523.5 16720.5 17654.2 15352.8 15503.1 15600.4 15656.2 16172.4 5261.4 5465.5 5466.6 5469.0 5473.4 3999.8 4117.7 5339.6 5637.0 5837.8 5630.9 5792.4 5829.4 5845.4 5927.0 5889.9 5922.4 5927.2 5931.4 5957.9 5130.5 5220.7 5301.4 5315.5 5321.1 19267.0 19677.1 19780.9 19952.8 20362.5 663.6 1404.5 1565.6 2308.9 2521.8 12463.1 12609.3 12686.6 12845.7 13115.0 1826.6 1834.4 1875.6 1887.3 1906.2 51024.7 51624.2 52039.5 52696.2 52747.7 9491.7 9640.6 9811.4 9829.8 9917.0 12698.0 12849.9 12850.2 12853.4 12864.2 7391.6 7464.4 7626.7 7685.3 7701.9 7298.0 7301.3 7370.9 7377.2 7419.3 5206.8 5847.4 5863.4 5874.4 5885.8 1716.2 1743.9 1782.3 1794.4 1795.8 426.9 433.8 437.3 440.6 992.5 9257.6 10679.4 10859.1 10949.4 11258.2 444.5 448.0 451.0 462.8 475.3 5877.9 5936.2 6227.8 6247.5 6312.6 558448.0 558821.0 559257.0 568524.0 571936.0 64016.7 67770.0 68764.0 68883.0 69911.0 1004.3 1034.3 1071.5 1103.6 1114.5 14087.6 14204.9 14646.7 15137.3 15429.5 29418.3 29956.6 30355.5 31086.5 31404.5 37092.8 39135.8 41248.4 41308.6 41345.4 7055.5 7370.9 7505.4 7577.4 7608.0 10506.8 10689.9 10836.9 11256.7 11592.9 9063.5 9296.0 9325.2 9632.3 9647.0 9082.8 9134.3 9150.7 9455.1 9484.7 9420.2 9726.7 9782.4 10199.5 10533.3 7506.1 7514.1 7586.8 7624.3 7640.7 9023.0 9238.7 9826.0 9921.0 9963.1 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#3] mootools.html Cycles:180 Average:5500.41 Median:6517.22 stddev:2789.41 (42.8%) stddev-sans-first:2779.08 05:59:02 INFO - PROCESS | 27306 | Values: 1267.8 1452.7 1482.4 1655.8 1821.2 6681.4 7698.2 7826.9 7846.1 7865.9 7675.8 7833.8 7834.3 7835.0 7857.9 2047.4 2087.9 2306.9 2308.4 2332.0 2345.9 2351.7 2355.7 2355.9 2357.5 2282.9 2348.1 2352.0 2353.1 2353.2 2321.8 2349.9 2378.6 2378.9 2380.8 2349.2 2355.2 2384.1 2385.6 2386.6 7954.1 8003.4 8004.0 8004.8 8008.2 4805.7 4866.1 4873.8 4873.9 4910.3 3101.8 3166.3 3216.3 3224.4 3224.8 969.4 985.6 1030.1 1032.7 1061.3 10483.9 10514.8 10520.3 10525.4 10532.3 4460.0 4473.3 4521.8 4568.9 4595.1 8635.4 8673.7 8772.4 8776.7 8783.6 4841.4 4879.7 4894.5 4896.6 4931.9 4449.2 4493.9 4498.0 4502.5 4504.7 3334.1 3390.9 3652.7 3654.8 3732.0 1169.9 1199.9 1200.5 1200.6 1209.4 1295.4 1319.1 1336.7 1364.7 1369.2 7247.1 7391.0 7395.1 7398.7 7406.1 1113.7 1119.2 1125.2 1126.5 1134.4 5808.7 5849.2 5885.5 5885.8 5886.9 9048.6 9192.8 9230.1 9388.3 9427.4 9224.4 9257.8 9268.6 9270.0 9271.2 7165.1 7235.6 7297.4 7399.1 7404.9 7366.3 7386.2 7437.9 7444.5 7452.4 8477.5 8477.7 8610.7 8752.7 8756.8 8581.3 8983.5 8988.9 8994.6 9000.7 6072.4 6829.0 6878.3 6892.2 6893.8 6731.3 7117.0 7297.4 7298.5 7301.6 6935.3 7123.0 7131.1 7173.7 7256.7 6931.9 6934.9 7006.5 7113.4 7148.1 6846.7 6847.6 6883.5 6895.4 7074.9 6489.1 6513.4 6521.0 6533.7 6537.5 6570.5 6589.4 6602.8 6604.0 6611.2 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#4] prototype.html Cycles:180 Average:5225.86 Median:5913.16 stddev:1567.15 (26.5%) stddev-sans-first:1528.00 05:59:02 INFO - PROCESS | 27306 | Values: 338.3 339.5 342.8 346.0 352.4 5737.9 5840.1 5875.4 5941.3 5997.7 5654.4 5775.9 5784.2 5787.5 5798.7 4587.4 4593.7 4595.5 4596.9 4598.2 4357.4 4456.9 4501.2 4571.5 4601.1 4490.6 4507.1 4518.2 4519.7 4528.6 4517.8 4519.5 4525.6 4533.2 4562.7 4046.9 4051.0 4057.7 4059.5 4060.6 5459.0 5607.6 5609.4 5643.8 5649.0 5198.8 5211.3 5216.1 5219.4 5221.6 5952.1 6241.4 6251.8 6253.4 6257.4 4262.0 4295.1 4326.4 4326.4 4331.8 6300.7 6509.3 6522.5 6551.6 6577.1 4394.2 4398.4 4398.9 4399.7 4403.0 4341.5 4412.3 4443.8 4447.6 4456.4 5132.8 5148.8 5156.8 5168.1 5168.9 6215.5 6245.4 6257.2 6257.9 6265.0 1586.0 1610.3 1611.2 1611.8 1614.3 1079.1 1080.7 1086.8 1109.0 1112.9 5912.9 5920.2 5926.4 5927.1 5934.4 6421.0 6421.6 6426.4 6427.2 6435.2 5897.1 5912.0 5913.5 5917.8 5921.9 3374.2 3493.8 3496.6 3500.8 3501.9 6713.6 6718.3 6723.9 6727.2 6733.6 6677.2 6687.8 6687.9 6697.0 6697.5 6522.1 6668.3 6703.0 6711.5 6713.5 6255.2 6356.6 6489.8 6494.9 6496.5 6244.9 6298.9 6347.9 6407.9 6418.6 6655.9 6672.5 6682.9 6691.2 6696.1 4366.6 4386.8 4397.9 4399.2 4399.9 6416.1 6426.8 6429.2 6444.8 6446.0 6240.7 6243.1 6244.2 6249.4 6251.9 6149.1 6227.1 6229.2 6233.2 6289.7 6159.3 6168.8 6184.9 6194.8 6200.5 6339.6 6343.7 6349.1 6349.7 6351.8 6075.8 6169.6 6170.3 6184.0 6187.4 05:59:02 INFO - PROCESS | 27306 | 05:59:02 INFO - PROCESS | 27306 | [#5] yui.html Cycles:180 Average:12969.86 Median:55015.00 stddev:15317.00 (27.8%) stddev-sans-first:15332.33 05:59:02 INFO - PROCESS | 27306 | Values: 717.5 734.6 782.0 815.8 834.3 12906.9 13029.8 13037.9 13053.8 13064.7 12251.2 12465.3 12595.1 12686.4 12727.7 654.3 659.1 793.3 803.7 804.9 789.2 799.0 804.4 805.4 806.6 847.2 847.2 847.5 847.8 848.4 690.8 699.5 700.1 828.1 844.2 614.9 615.6 615.6 616.6 617.1 12985.2 13027.7 13032.8 13073.3 13092.4 11488.2 11946.8 11991.8 12109.8 12354.7 9029.1 9342.8 9439.0 9485.5 9610.0 3335.7 3356.6 3413.8 3486.5 3492.8 44719.0 45046.5 45057.0 45332.3 46027.5 8982.4 9083.1 9202.1 9284.5 9307.5 15003.5 15147.7 15161.9 15189.4 15227.3 6821.5 6841.2 6895.5 6997.4 7058.9 3693.1 3698.2 3725.0 3742.7 3771.1 3224.2 3226.4 3244.5 3248.2 3249.0 601.7 610.6 610.7 613.8 615.1 478.5 507.4 562.9 586.9 610.0 8017.5 8264.5 8284.7 8343.8 8459.5 488.7 493.8 581.6 583.0 586.4 3734.2 3817.0 3994.6 4047.6 4180.2 54280.5 54325.5 54905.0 55125.0 55332.0 48632.3 50001.7 50309.5 50385.0 50623.7 44162.0 44392.6 45041.0 45238.8 45473.8 8181.0 8216.1 8219.6 8320.9 8330.8 33004.0 33688.8 33906.8 34185.7 34393.1 40563.0 41607.2 43475.8 43565.8 43684.8 9482.1 9624.9 9655.5 9677.4 9773.1 10201.0 10418.3 10437.6 10451.4 10453.8 9807.3 9854.2 9858.6 10126.9 10154.3 9827.0 9870.4 10035.5 10059.2 10241.3 7600.8 10118.2 10255.9 10322.8 10577.9 8394.1 8404.0 8404.5 8523.8 9059.6 8678.4 8937.6 9051.5 9084.1 9099.1 05:59:02 INFO - PROCESS | 27306 | -------- Summary: end -------- 05:59:02 INFO - PROCESS | 27306 | 05:59:03 INFO - TEST-INFO | 27306: exit 0 05:59:03 INFO - TEST-OK | dromaeo_css | took 1113062ms 05:59:03 INFO - TEST-START | kraken 05:59:03 INFO - operating with platform_type : linux_ 05:59:03 INFO - Initialising browser for kraken test... 05:59:03 INFO - TEST-INFO | started process 27507 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS6PNd6/profile http://localhost:54564/getInfo.html) 05:59:07 INFO - PROCESS | 27507 | __metrics Screen width/height:1600/1200 05:59:07 INFO - PROCESS | 27507 | colorDepth:24 05:59:07 INFO - PROCESS | 27507 | Browser inner width/height: 1024/697 05:59:07 INFO - PROCESS | 27507 | __metrics 05:59:07 INFO - PROCESS | 27507 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:59:07 INFO - PROCESS | 27507 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:08 INFO - TEST-INFO | 27507: exit 0 05:59:08 INFO - Browser initialized. 05:59:08 INFO - Running cycle 1/1 for kraken test... 05:59:08 INFO - TEST-INFO | started process 27585 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS6PNd6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:20 INFO - PROCESS | 27585 | RSS: Main: 149929984 05:59:20 INFO - PROCESS | 27585 | 05:59:22 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54564/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:23 INFO - PROCESS | 27585 | RSS: Main: 185675776 05:59:23 INFO - PROCESS | 27585 | 05:59:26 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54564/tests/kraken/driver.html?testName=audio-dft) 05:59:26 INFO - PROCESS | 27585 | RSS: Main: 176111616 05:59:26 INFO - PROCESS | 27585 | 05:59:29 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54564/tests/kraken/driver.html?testName=audio-fft) 05:59:30 INFO - PROCESS | 27585 | RSS: Main: 162160640 05:59:30 INFO - PROCESS | 27585 | 05:59:32 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54564/tests/kraken/driver.html?testName=audio-oscillator) 05:59:32 INFO - PROCESS | 27585 | RSS: Main: 162291712 05:59:32 INFO - PROCESS | 27585 | 05:59:35 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:35 INFO - PROCESS | 27585 | RSS: Main: 166682624 05:59:35 INFO - PROCESS | 27585 | 05:59:38 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54564/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:39 INFO - PROCESS | 27585 | RSS: Main: 166801408 05:59:39 INFO - PROCESS | 27585 | 05:59:42 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54564/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:43 INFO - PROCESS | 27585 | RSS: Main: 166801408 05:59:43 INFO - PROCESS | 27585 | 05:59:45 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54564/tests/kraken/driver.html?testName=json-parse-financial) 05:59:46 INFO - PROCESS | 27585 | RSS: Main: 166674432 05:59:46 INFO - PROCESS | 27585 | 05:59:47 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:48 INFO - PROCESS | 27585 | RSS: Main: 175939584 05:59:48 INFO - PROCESS | 27585 | 05:59:50 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:50 INFO - PROCESS | 27585 | RSS: Main: 175218688 05:59:50 INFO - PROCESS | 27585 | 05:59:52 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:53 INFO - PROCESS | 27585 | RSS: Main: 182013952 05:59:53 INFO - PROCESS | 27585 | 05:59:55 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:56 INFO - PROCESS | 27585 | RSS: Main: 188329984 05:59:56 INFO - PROCESS | 27585 | 05:59:58 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:59 INFO - PROCESS | 27585 | RSS: Main: 188272640 05:59:59 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | Cycle 1(1): loaded http://localhost:54564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54564/tests/kraken/driver.html?testName=ai-astar) 06:00:01 INFO - PROCESS | 27585 | RSS: Main: 245477376 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | __start_tp_report 06:00:01 INFO - PROCESS | 27585 | _x_x_mozilla_page_load 06:00:01 INFO - PROCESS | 27585 | _x_x_mozilla_page_load_details 06:00:01 INFO - PROCESS | 27585 | |i|pagename|runs| 06:00:01 INFO - PROCESS | 27585 | |0;ai-astar;108;111;105;109;109;110;101;112;110;109 06:00:01 INFO - PROCESS | 27585 | |1;audio-beat-detection;152;126;152;171;126;153;152;127;170;127 06:00:01 INFO - PROCESS | 27585 | |2;audio-dft;161;160;161;163;162;162;159;163;161;161 06:00:01 INFO - PROCESS | 27585 | |3;audio-fft;75;73;106;91;74;72;72;117;95;71 06:00:01 INFO - PROCESS | 27585 | |4;audio-oscillator;104;95;136;95;96;95;144;96;96;132 06:00:01 INFO - PROCESS | 27585 | |5;imaging-gaussian-blur;110;110;109;109;108;109;108;109;109;109 06:00:01 INFO - PROCESS | 27585 | |6;imaging-darkroom;146;145;147;145;146;145;146;144;145;145 06:00:01 INFO - PROCESS | 27585 | |7;imaging-desaturate;96;95;95;95;96;95;96;95;96;96 06:00:01 INFO - PROCESS | 27585 | |8;json-parse-financial;58;58;58;58;58;58;58;66;55;55 06:00:01 INFO - PROCESS | 27585 | |9;json-stringify-tinderbox;69;69;69;69;69;68;69;68;69;68 06:00:01 INFO - PROCESS | 27585 | |10;stanford-crypto-aes;79;81;82;81;81;81;83;81;81;81 06:00:01 INFO - PROCESS | 27585 | |11;stanford-crypto-ccm;115;115;115;114;115;123;116;116;124;113 06:00:01 INFO - PROCESS | 27585 | |12;stanford-crypto-pbkdf2;149;145;148;141;135;131;142;142;144;146 06:00:01 INFO - PROCESS | 27585 | |13;stanford-crypto-sha256-iterative;66;66;66;65;66;68;66;68;67;66 06:00:01 INFO - PROCESS | 27585 | __end_tp_report 06:00:01 INFO - PROCESS | 27585 | __start_cc_report 06:00:01 INFO - PROCESS | 27585 | _x_x_mozilla_cycle_collect,955 06:00:01 INFO - PROCESS | 27585 | __end_cc_report 06:00:01 INFO - PROCESS | 27585 | __startTimestamp1452952801463__endTimestamp 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | ------- Summary: start ------- 06:00:01 INFO - PROCESS | 27585 | Number of tests: 14 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:3.20 (2.9%) stddev-sans-first:3.40 06:00:01 INFO - PROCESS | 27585 | Values: 108.0 111.0 105.0 109.0 109.0 110.0 101.0 112.0 110.0 109.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.00 stddev:17.88 (11.8%) stddev-sans-first:18.82 06:00:01 INFO - PROCESS | 27585 | Values: 152.0 126.0 152.0 171.0 126.0 153.0 152.0 127.0 170.0 127.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 06:00:01 INFO - PROCESS | 27585 | Values: 161.0 160.0 161.0 163.0 162.0 162.0 159.0 163.0 161.0 161.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:16.66 (22.7%) stddev-sans-first:17.31 06:00:01 INFO - PROCESS | 27585 | Values: 75.0 73.0 106.0 91.0 74.0 72.0 72.0 117.0 95.0 71.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:20.01 (21.1%) stddev-sans-first:21.14 06:00:01 INFO - PROCESS | 27585 | Values: 104.0 95.0 136.0 95.0 96.0 95.0 144.0 96.0 96.0 132.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 06:00:01 INFO - PROCESS | 27585 | Values: 110.0 110.0 109.0 109.0 108.0 109.0 108.0 109.0 109.0 109.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 06:00:01 INFO - PROCESS | 27585 | Values: 146.0 145.0 147.0 145.0 146.0 145.0 146.0 144.0 145.0 145.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:00:01 INFO - PROCESS | 27585 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.01 (5.2%) stddev-sans-first:3.19 06:00:01 INFO - PROCESS | 27585 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 58.0 66.0 55.0 55.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 06:00:01 INFO - PROCESS | 27585 | Values: 69.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 68.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:0.99 (1.2%) stddev-sans-first:0.71 06:00:01 INFO - PROCESS | 27585 | Values: 79.0 81.0 82.0 81.0 81.0 81.0 83.0 81.0 81.0 81.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:115.50 stddev:3.75 (3.2%) stddev-sans-first:3.93 06:00:01 INFO - PROCESS | 27585 | Values: 115.0 115.0 115.0 114.0 115.0 123.0 116.0 116.0 124.0 113.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.50 stddev:5.62 (3.9%) stddev-sans-first:5.41 06:00:01 INFO - PROCESS | 27585 | Values: 149.0 145.0 148.0 141.0 135.0 131.0 142.0 142.0 144.0 146.0 06:00:01 INFO - PROCESS | 27585 | 06:00:01 INFO - PROCESS | 27585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 06:00:01 INFO - PROCESS | 27585 | Values: 66.0 66.0 66.0 65.0 66.0 68.0 66.0 68.0 67.0 66.0 06:00:01 INFO - PROCESS | 27585 | -------- Summary: end -------- 06:00:01 INFO - PROCESS | 27585 | 06:00:02 INFO - TEST-INFO | 27585: exit 0 06:00:02 INFO - TEST-OK | kraken | took 59138ms 06:00:02 INFO - TEST-START | v8_7 06:00:02 INFO - operating with platform_type : linux_ 06:00:02 INFO - Initialising browser for v8_7 test... 06:00:02 INFO - TEST-INFO | started process 27833 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9sdDhU/profile http://localhost:54564/getInfo.html) 06:00:06 INFO - PROCESS | 27833 | __metrics Screen width/height:1600/1200 06:00:06 INFO - PROCESS | 27833 | colorDepth:24 06:00:06 INFO - PROCESS | 27833 | Browser inner width/height: 1024/697 06:00:06 INFO - PROCESS | 27833 | __metrics 06:00:06 INFO - PROCESS | 27833 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:00:06 INFO - PROCESS | 27833 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:07 INFO - TEST-INFO | 27833: exit 0 06:00:07 INFO - Browser initialized. 06:00:07 INFO - Running cycle 1/1 for v8_7 test... 06:00:07 INFO - TEST-INFO | started process 27918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9sdDhU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:19 INFO - PROCESS | 27918 | RSS: Main: 149553152 06:00:19 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | Cycle 1(1): loaded http://localhost:54564/tests/v8_7/run.html (next: http://localhost:54564/tests/v8_7/run.html) 06:00:42 INFO - PROCESS | 27918 | RSS: Main: 580968448 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | __start_tp_report 06:00:42 INFO - PROCESS | 27918 | _x_x_mozilla_page_load 06:00:42 INFO - PROCESS | 27918 | _x_x_mozilla_page_load_details 06:00:42 INFO - PROCESS | 27918 | |i|pagename|runs| 06:00:42 INFO - PROCESS | 27918 | |0;Richards;167.81339150864238 06:00:42 INFO - PROCESS | 27918 | |1;DeltaBlue;188.43037497644622 06:00:42 INFO - PROCESS | 27918 | |2;Encrypt;279.17364600781684 06:00:42 INFO - PROCESS | 27918 | |3;Decrypt;5246.073298429319 06:00:42 INFO - PROCESS | 27918 | |4;RayTrace;1947.4708171206225 06:00:42 INFO - PROCESS | 27918 | |5;Earley;769.2307692307693 06:00:42 INFO - PROCESS | 27918 | |6;Boyer;12268.292682926829 06:00:42 INFO - PROCESS | 27918 | |7;RegExp;43083.333333333336 06:00:42 INFO - PROCESS | 27918 | |8;Splay;607.6178960096735 06:00:42 INFO - PROCESS | 27918 | |9;NavierStokes;4830.917874396136 06:00:42 INFO - PROCESS | 27918 | __end_tp_report 06:00:42 INFO - PROCESS | 27918 | __startTimestamp1452952842331__endTimestamp 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | ------- Summary: start ------- 06:00:42 INFO - PROCESS | 27918 | Number of tests: 10 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 167.8 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 188.4 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 279.2 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 5246.1 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#4] RayTrace Cycles:1 Average:1947.47 Median:1947.47 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 1947.5 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#5] Earley Cycles:1 Average:769.23 Median:769.23 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 769.2 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 12268.3 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#7] RegExp Cycles:1 Average:43083.33 Median:43083.33 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 43083.3 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#8] Splay Cycles:1 Average:607.62 Median:607.62 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 607.6 06:00:42 INFO - PROCESS | 27918 | 06:00:42 INFO - PROCESS | 27918 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:00:42 INFO - PROCESS | 27918 | Values: 4830.9 06:00:42 INFO - PROCESS | 27918 | -------- Summary: end -------- 06:00:42 INFO - PROCESS | 27918 | 06:00:43 INFO - TEST-INFO | 27918: exit 0 06:00:43 INFO - TEST-OK | v8_7 | took 40782ms 06:00:43 INFO - SUITE-END | took 1212s 06:00:43 INFO - Completed test suite (00:20:13) 06:00:43 INFO - Working with test: dromaeo_css 06:00:43 INFO - Generating results file: dromaeo_css 06:00:43 INFO - Working with test: kraken 06:00:43 INFO - Generating results file: kraken 06:00:43 INFO - javascript benchmark 06:00:43 INFO - Working with test: v8_7 06:00:43 INFO - Generating results file: v8_7 06:00:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:00:43 INFO - process_Request line: dromaeo_css 6673.98 graph.html#tests=[[72,1,35]] 06:00:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:43 INFO - process_Request line: kraken 1492.00 graph.html#tests=[[232,1,35]] 06:00:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:43 INFO - process_Request line: v8_7 18918.82 graph.html#tests=[[230,1,35]] 06:00:43 INFO - RETURN: dromaeo_css: 6673.98 06:00:43 INFO - RETURN: kraken: 1492.00 06:00:43 INFO - RETURN: v8_7: 18918.82 06:00:43 INFO - javascript benchmark 06:00:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3162.193640621642, 3183.5065564837446, 3217.099212220579, 3238.125706059365, 3254.235254715143, 5034.899302013958, 5150.587952963763, 5182.896342073156, 5188.325517682696, 5193.350831146102, 5196.92204616931, 5209.557187639046, 5236.528712415882, 5247.632665713401, 5253.264542963988, 4732.550407711271, 4767.1419144553965, 4775.71345719258, 4814.470408255107, 4830.661853670244, 4752.287156926454, 4752.906831428773, 4762.928556071662, 4797.7121372717575, 4804.37543119394, 4605.562471565196, 4705.294205869112, 4736.573708366229, 4822.348982887301, 4829.203181475053, 4746.240601503778, 4769.117713223065, 4773.260144677581, 4784.904301913977, 4812.205986012304, 4630.073985202973, 4747.287906813971, 4747.715137091751, 4770.236762118045, 4799.544043315879, 4903.387076615423, 4939.925901111486, 4955.0833095877015, 4962.627802914796, 4994.275830004665, 5601.29983752031, 5612.326520817487, 5625.746841392147, 5628.465295796893, 5633.943660563383, 5498.092814685612, 5604.299462567179, 5646.096624540095, 5658.547316214693, 5660.349059858087, 5210.609204309692, 5269.473052694738, 5287.127623942045, 5290.470952904756, 5330.946690533084, 5768.4808367246305, 5769.249997500298, 5770.88458230833, 5777.711114444261, 5782.508486778671, 5380.973095134577, 5474.534664553478, 5477.315335583052, 5539.25220095282, 5549.056660367747, 5526.143447765603, 5609.971950140223, 5617.157426385993, 5618.157276408571, 5663.405342439067, 5466.753996070107, 5483.616146869761, 5486.506214440719, 5497.917531237034, 5500.42245564218, 5352.705601191894, 5461.918071228934, 5482.533984611353, 5502.58730595207, 5530.446955304437, 4327.2643650579475, 4341.804618792162, 4342.652587792969, 4370.191514569751, 4378.737275763465, 3880.068783491998, 3889.922201555953, 3890.9494436501986, 3921.0197450637343, 3925.6270654287796, 5018.899622007612, 5094.2103973884105, 5155.561777248976, 5178.508041736029, 5243.68537887728, 5568.220449137124, 5571.860703482364, 5578.693171875505, 5597.216389705444, 5598.10430331145, 5187.559057480081, 5196.714180720021, 5201.661891977009, 5202.323697919322, 5248.527632513016, 4659.767011649404, 4735.1240020595615, 4740.288956656529, 4783.995360974165, 4822.469528351879, 5772.913406298909, 5824.563157763185, 5827.533797296291, 5828.59199856006, 5836.2412886325355, 5452.400235974119, 5624.690642014565, 5635.520980716521, 5653.0, 5700.287464066992, 5618.69097199658, 5761.251037365116, 5795.565332600157, 5814.069748840166, 5854.648721076749, 5481.150421684645, 5493.587980901369, 5497.092979658471, 5500.724963751716, 5504.972475137599, 5377.193420986883, 5492.093804522209, 5564.221009058654, 5566.304211973504, 5570.972145139248, 5404.783808647768, 5442.972785136049, 5447.700376479332, 5455.208994695826, 5487.094629386266, 5309.628326017141, 5319.867003324793, 5320.2817619620855, 5330.413654497925, 5371.40914499397, 5190.09173394662, 5218.321618189611, 5244.239585260192, 5269.420363759907, 5301.787928482818, 5390.407055223844, 5435.076037073786, 5442.673439593637, 5466.2620546227345, 5491.983982963165, 5332.466753324792, 5332.733363331896, 5336.2529245904825, 5338.3060202173465, 5343.225232341367], "unit": "score", "name": "dojo.html", "value": 5136.459314637959}, {"lowerIsBetter": false, "replicates": [492.33288893549263, 546.1643685161703, 565.5164834066871, 577.416809022887, 596.94341016401, 27566.31084222893, 27711.445771084593, 27763.444731105366, 28070.71929280709, 35743.64256357442, 38868.22263554734, 38936.610633893724, 39170.412443813366, 39172.60827391725, 39310.479294881094, 8338.45800022998, 8514.446560973547, 8547.871781923277, 8557.443766155211, 8598.656053757843, 8281.875771863426, 8355.456895301817, 8418.915810841874, 8420.621072051741, 8430.072692003905, 8398.45410048348, 8640.135986401341, 8683.34874884383, 8686.174813392718, 8687.782805429852, 8579.313654907592, 8635.309175265964, 8653.956730216372, 8658.696945606936, 8664.090270521567, 8425.831483370299, 8649.437786543918, 8651.956740216321, 8660.913390866137, 8663.306935445149, 39267.60732392697, 39689.60310396888, 39712.20575588472, 39760.60239397627, 39764.0, 3486.0, 3504.0, 3511.10466830959, 3672.908177295589, 3948.5853985331414, 29718.70281297181, 29843.813215190177, 30146.0, 30530.84734576313, 31178.688213117806, 3722.4416337549314, 3743.5320584926885, 3745.4569087482164, 3830.9425358619364, 3866.4780254665543, 245767.0, 246587.0, 247105.0, 247219.0, 248761.0, 51855.740721296905, 52748.472515274356, 57474.7126264366, 60074.09888851671, 60567.39432605617, 59688.0, 59782.402175978554, 59913.40086599165, 60090.0, 60099.39900601025, 15740.0, 15918.9204053979, 15923.442679506394, 15948.920255398649, 15972.0, 10958.780824383468, 11223.270487418291, 11444.484998175101, 11745.29528228309, 11759.706007349714, 19197.90401048014, 19277.325293614656, 20017.526040110708, 20057.29799457012, 20091.497712557302, 7666.3866890648615, 7680.270374314431, 7737.110232323243, 7810.765677029584, 7831.569263690551, 886.4946980221212, 946.9337146399823, 1030.8866024737272, 1031.3811712972156, 1074.3607553505651, 28188.577171342447, 28668.80233126756, 28760.424791504054, 28971.13086607363, 29068.418631627672, 1031.7721910925975, 1097.9560817567367, 1106.435717783936, 1167.422126047595, 1203.0676225924979, 15041.57105075016, 15097.169655669044, 15423.845761542465, 15529.689406211812, 15796.289166987513, 263267.0, 263764.0, 264611.0, 264928.0, 266141.0, 48360.0, 48521.75739121282, 48672.75663621659, 48738.0, 48840.7557962215, 1320.3530270167741, 1329.8271224740915, 1347.5553067487706, 1349.5006847466304, 1349.9548184500686, 25429.0, 28183.154505364873, 28634.570481442377, 29670.554941676324, 30281.69718302877, 45331.54668453273, 45664.54335456603, 45666.08667826691, 45684.543154568026, 45729.771351143034, 199385.0, 201263.0, 201689.0, 201718.0, 202016.0, 27293.454130917667, 27941.30146746266, 30905.845470772503, 30950.0, 32007.359852803278, 37381.43927841139, 37450.81274593718, 37743.433848491746, 37855.242895142495, 38467.0, 32364.35271294608, 32431.513527297582, 32615.18462038468, 32723.836380817942, 33109.83445082759, 34498.655013450545, 34656.0, 34694.0, 34807.651923480444, 34902.30195396129, 32403.18992025124, 32627.34745305033, 32977.51601177905, 33025.174370640925, 33222.5016624746, 29102.70897291, 30220.84889575538, 31234.375312494078, 31671.84164079165, 31672.208194795316, 24521.386965326008, 24757.381065473506, 24813.751862481866, 25066.498670026864, 25189.0], "unit": "score", "name": "ext.html", "value": 17671.025372157197}, {"lowerIsBetter": false, "replicates": [369.13806262377346, 369.29464722380243, 369.75411351451277, 372.2573465935459, 377.18339794345246, 13523.864761352383, 13627.727445451084, 15523.456679016237, 16720.498385048453, 17654.205560749764, 15352.84647153531, 15503.147326897017, 15600.375984960616, 15656.217189140554, 16172.35310587575, 5261.394939581949, 5465.453454654543, 5466.562674985991, 5469.0, 5473.425290344516, 3999.800009999503, 4117.670586353084, 5339.6262261641705, 5636.971815140919, 5837.766489340422, 5630.915536266959, 5792.4497172768515, 5829.387914268983, 5845.357010728816, 5927.02204136317, 5889.8822023559715, 5922.378150294222, 5927.199828023205, 5931.377205393458, 5957.940420595782, 5130.51260130287, 5220.73896305187, 5301.363836339626, 5315.521603055705, 5321.148616221425, 19267.0, 19677.114529846047, 19780.90109549443, 19952.80047199524, 20362.490937726674, 663.5819433756702, 1404.473322504061, 1565.5616427400346, 2308.9307320780404, 2521.8108641851936, 12463.12758106933, 12609.30648814315, 12686.619401417973, 12845.67885802853, 13115.0, 1826.5981484073482, 1834.385480863912, 1875.559243577758, 1887.282832523646, 1906.20892329683, 51024.744876275756, 51624.22563661548, 52039.479605203844, 52696.20955685668, 52747.736261318445, 9491.66779162726, 9640.566174522164, 9811.411315321104, 9829.754256143653, 9917.0, 12698.031805070228, 12849.935750321376, 12850.228986260854, 12853.357332133355, 12864.16382935125, 7391.630418479054, 7464.365528929993, 7626.656800443993, 7685.346745526581, 7701.884471732928, 7298.0, 7301.342879140902, 7370.852582948311, 7377.151627562792, 7419.258074192538, 5206.817761378334, 5847.415258474203, 5863.384344643751, 5874.412558744091, 5885.793997210163, 1716.2448522649995, 1743.8953662780273, 1782.2603619497763, 1794.4078454110374, 1795.7845058593052, 426.8591364849592, 433.8481531463962, 437.26321148864264, 440.60345688879625, 992.533509250651, 9257.629694812267, 10679.359238445719, 10859.13126949842, 10949.397783122005, 11258.155638327158, 444.4533224134333, 448.0456627383652, 450.9582863585129, 462.77555385637936, 475.25622400942416, 5877.941220587825, 5936.198613187251, 6227.750889964351, 6247.500199983991, 6312.621242725451, 558448.0, 558821.0, 559257.0, 568524.0, 571936.0, 64016.67991660105, 67770.0, 68764.0, 68883.0, 69911.0, 1004.2869562610629, 1034.3225187502198, 1071.5071067309125, 1103.6192513582962, 1114.5374669512062, 14087.647808804863, 14204.928975355057, 14646.70706585841, 15137.318820653318, 15429.537113886601, 29418.264543386587, 29956.550651739806, 30355.544666830458, 31086.533701994034, 31404.528932066496, 37092.81453592715, 39135.80432097821, 41248.38127428031, 41308.58691413047, 41345.379819303336, 7055.541389809646, 7370.852582948418, 7505.437092218214, 7577.393808495197, 7608.01095857535, 10506.789864202827, 10689.9465502672, 10836.891631083588, 11256.718582035515, 11592.942035289769, 9063.546822658973, 9295.977442481457, 9325.160735533835, 9632.325737198329, 9647.0, 9082.772930676785, 9134.26925845944, 9150.725478235663, 9455.14903658674, 9484.668036618685, 9420.152186303265, 9726.659566915125, 9782.364146330467, 10199.54102065394, 10533.26267161322, 7506.099268087864, 7514.098308202832, 7586.772396828104, 7624.27569380908, 7640.732574360093, 9022.954885225532, 9238.676646317346, 9825.95087024589, 9920.966201928442, 9963.103320700882], "unit": "score", "name": "jquery.html", "value": 7689.543406395818}, {"lowerIsBetter": false, "replicates": [1267.8161666558344, 1452.7457694903392, 1482.3625840888417, 1655.8178600353958, 1821.225978958942, 6681.432078273347, 7698.191689872559, 7826.943362646041, 7846.136924938267, 7865.882011769813, 7675.846483070335, 7833.764987050384, 7834.2949134577875, 7835.020622422197, 7857.882131768014, 2047.4471892588992, 2087.8956052197404, 2306.942326441844, 2308.3882771065637, 2331.976680233193, 2345.8827058647084, 2351.6590094436297, 2355.7290911545133, 2355.9411014724683, 2357.49313897512, 2282.942926426836, 2348.131191459154, 2352.047420794581, 2353.0940587873706, 2353.188150088217, 2321.779430954057, 2349.859008459498, 2378.63131214662, 2378.9167379141645, 2380.8095352371943, 2349.189529612281, 2355.2463211772238, 2384.070212617081, 2385.5705972924866, 2386.5942789725786, 7954.085280192794, 8003.359731221488, 8004.0, 8004.759857204293, 8008.239217274349, 4805.687630304054, 4866.124097662419, 4873.756312184377, 4873.878153046202, 4910.263460480956, 3101.7673674474504, 3166.319241363095, 3216.292415668549, 3224.3551289742145, 3224.790388624732, 969.3892847506097, 985.5614251658016, 1030.1398332392462, 1032.7211652853762, 1061.2518174686827, 10483.895161048367, 10514.842277365846, 10520.263581549294, 10525.36847789135, 10532.26274160809, 4459.996500787362, 4473.329000649864, 4521.8191272349395, 4568.931466028012, 4595.058013107305, 8635.352348573882, 8673.696420625249, 8772.38593298463, 8776.736697899074, 8783.604737786814, 4841.443234028062, 4879.682820616648, 4894.486078961658, 4896.608271338356, 4931.876703082452, 4449.243628583149, 4493.865184044484, 4498.032922921588, 4502.5047244803045, 4504.684672072989, 3334.1164591383304, 3390.9491357629654, 3652.671259586597, 3654.780713157219, 3732.0296722852254, 1169.8771628978834, 1199.8500187476566, 1200.5317926008863, 1200.5857978997233, 1209.371127013948, 1295.3846922711637, 1319.0766463475607, 1336.6591519162746, 1364.6861221918816, 1369.1511263016794, 7247.13034435871, 7391.0, 7395.075615548057, 7398.704051837866, 7406.07424071991, 1113.6881673131536, 1119.1885882735114, 1125.2348403085816, 1126.5381193710539, 1134.4044376702298, 5808.709564521757, 5849.239598852207, 5885.470307672244, 5885.793997210077, 5886.882262354815, 9048.592813323416, 9192.81614367709, 9230.123138301851, 9388.34281600295, 9427.434353938786, 9224.354295199271, 9257.768555786024, 9268.629254829732, 9270.0, 9271.211946984447, 7165.104361954755, 7235.638218089074, 7297.379722723628, 7399.149097853708, 7404.888926666212, 7366.300201480851, 7386.15059268191, 7437.851242975002, 7444.516106453063, 7452.403807695479, 8477.533735644352, 8477.703280385156, 8610.698625548326, 8752.69365572202, 8756.78108047304, 8581.27059199975, 8983.505907175168, 8988.86516702263, 8994.59524321394, 9000.729978100668, 6072.392760723892, 6829.043933849364, 6878.27778083314, 6892.207396149507, 6893.827654308482, 6731.293214212437, 7116.964415177891, 7297.379722723415, 7298.4891057625455, 7301.634918254173, 6935.271796461299, 7122.964385178041, 7131.0729605151, 7173.748918787817, 7256.673449694671, 6931.861362772615, 6934.930650693428, 7006.544574602634, 7113.359797618239, 7148.070750802362, 6846.691898864663, 6847.554908930903, 6883.518153729191, 6895.448364130958, 7074.858502829811, 6489.091527186292, 6513.4463570595135, 6521.0, 6533.705983230671, 6537.542372033912, 6570.5400621957915, 6589.4069533742195, 6602.8349291268105, 6604.042413849868, 6611.239707433707], "unit": "score", "name": "mootools.html", "value": 4553.425492946842}, {"lowerIsBetter": false, "replicates": [338.29971958046855, 339.50969637707414, 342.82344592534844, 345.9636738142495, 352.40443650231117, 5737.885242295151, 5840.0947853082735, 5875.385453473206, 5941.346451890288, 5997.700114994243, 5654.434556544344, 5775.913361299584, 5784.219130417392, 5787.47912687858, 5798.681072541009, 4587.38070360502, 4593.678442509034, 4595.517470665583, 4596.862094137181, 4598.195315819735, 4357.433533640622, 4456.910861782762, 4501.189785838547, 4571.542845715435, 4601.125786100647, 4490.57339552742, 4507.09858028394, 4518.209313370164, 4519.706219095765, 4528.615067719232, 4517.796699148546, 4519.457665080195, 4525.615322697558, 4533.229351010336, 4562.703424277444, 4046.9190616187807, 4051.027753339207, 4057.675385969145, 4059.533153687334, 4060.5736397678115, 5458.972705136489, 5607.635503692247, 5609.411011843738, 5643.774249030034, 5648.971755141198, 5198.792048318062, 5211.296474975868, 5216.113260745682, 5219.373675159005, 5221.608379371524, 5952.077427998667, 6241.375862413768, 6251.843703907393, 6253.374662533755, 6257.374262573751, 4262.041040765834, 4295.055087880662, 4326.351047342892, 4326.437563116806, 4331.848385306499, 6300.716467758962, 6509.2839787623325, 6522.4782017438965, 6551.574147680385, 6577.144971153767, 4394.209042372404, 4398.3842262083335, 4398.868033958986, 4399.670024748157, 4403.0, 4341.45731783527, 4412.294032954712, 4443.755593442327, 4447.644188464915, 4456.442944631921, 5132.794688212504, 5148.768305426265, 5156.845294641092, 5168.095583272988, 5168.870778230499, 6215.502759779207, 6245.437910588069, 6257.186565746515, 6257.8748425031245, 6264.968675156686, 1586.0483709774273, 1610.3478091373013, 1611.1702473226298, 1611.8307577704172, 1614.2655091933143, 1079.1097344690504, 1080.7298175456135, 1086.750047489082, 1109.040679811973, 1112.8998390144925, 5912.852178695481, 5920.2007728956905, 5926.436988486087, 5927.081302398135, 5934.43622855828, 6420.967895160495, 6421.614703117734, 6426.4216220540375, 6427.164468619049, 6435.227772667216, 5897.144913987534, 5912.0, 5913.467787899023, 5917.822465326047, 5921.940780592225, 3374.2407958209205, 3493.825308734553, 3496.5804103507744, 3500.807455589916, 3501.8774342897877, 6713.56361836479, 6718.260991290954, 6723.865522689519, 6727.192736871607, 6733.629650369178, 6677.165354330708, 6687.832804179934, 6687.866242675119, 6696.966515167393, 6697.464202863759, 6522.119513865662, 6668.266250774834, 6703.0, 6711.463082953352, 6713.4964877634375, 6255.218097737783, 6356.618602883842, 6489.772857949949, 6494.935050649433, 6496.480281577557, 6244.937550624436, 6298.937010630018, 6347.873042539216, 6407.8718425630295, 6418.614883107029, 6655.933440665725, 6672.5329226953645, 6682.9331706682315, 6691.1636045494315, 6696.0960270362875, 4366.628836548929, 4386.846460373999, 4397.890052748707, 4399.208142534247, 4399.934000989923, 6416.069669897932, 6426.839329016812, 6429.164208652845, 6444.806655800334, 6446.0, 6240.656763878031, 6243.063540468966, 6244.219472565929, 6249.437550620466, 6251.9062214067735, 6149.108379284889, 6227.0970709246, 6229.190205273286, 6233.158523599256, 6289.685515724104, 6159.260888693386, 6168.784092556739, 6184.907226391518, 6194.783182588768, 6200.503959683305, 6339.587926784744, 6343.682815859096, 6349.07938348946, 6349.746010159727, 6351.777687780906, 6075.787347442818, 6169.598976066542, 6170.290416602148, 6184.041473571604, 6187.412195841388], "unit": "score", "name": "prototype.html", "value": 4723.7006239869}, {"lowerIsBetter": false, "replicates": [717.4977515738984, 734.599643194459, 782.000069643772, 815.7593509914578, 834.3367023216542, 12906.870931290685, 13029.804552931713, 13037.934810325947, 13053.804192937114, 13064.73870522589, 12251.20367176133, 12465.252084874914, 12595.118341716083, 12686.429110690018, 12727.745445091092, 654.2933631677777, 659.1036190780559, 793.3256731777972, 803.7186984555417, 804.8551260773058, 789.17925357628, 798.9960050199741, 804.4127786715701, 805.3919290935365, 806.6249194124731, 847.1951645936385, 847.2120927537388, 847.504210037129, 847.8431490174306, 848.4273115646945, 690.8203866994593, 699.5383047188831, 700.1353328639152, 828.0891019878086, 844.2317491083115, 614.8555089553952, 615.5506480269429, 615.6152404747033, 616.5745635511482, 617.1360095865779, 12985.220886746825, 13027.674308142277, 13032.80450793239, 13073.280969546671, 13092.410841512155, 11488.195826292163, 11946.820797688042, 11991.820122698167, 12109.818352724717, 12354.691132721753, 9029.097090290918, 9342.813143737087, 9438.952805235998, 9485.525723713787, 9609.951950240275, 3335.7164641005543, 3356.647552007053, 3413.7951722896705, 3486.477028445728, 3492.772969756983, 44719.0, 45046.549534504564, 45057.0, 45332.320015199795, 46027.539724603, 8982.416142950688, 9083.091690830865, 9202.125798049176, 9284.535773211312, 9307.53462326881, 15003.549893503212, 15147.697046059016, 15161.924190378977, 15189.392424303125, 15227.314770835339, 6821.484005018398, 6841.213260475109, 6895.5173137879865, 6997.370236678622, 7058.858822823515, 3693.0951916780023, 3698.204885949534, 3725.0, 3742.719296052807, 3771.07608635886, 3224.1617179533023, 3226.435373809574, 3244.4808830586994, 3248.204189973472, 3248.951265731016, 601.6510423954184, 610.5603965145089, 610.6854969690613, 613.7729040255045, 615.1265203411167, 478.50474758624654, 507.3556583139392, 562.8930503204379, 586.9060950248025, 610.0117809149207, 8017.518948863087, 8264.479333803247, 8284.71003514886, 8343.791405214919, 8459.534725590152, 488.7092180152803, 493.75065591875875, 581.6103210848742, 582.967936763482, 586.4487381861122, 3734.2158146788934, 3817.0, 3994.6404823566018, 4047.5952404759287, 4180.1848639515, 54280.45719542754, 54325.45674543204, 54905.0, 55125.0, 55332.0, 48632.27051594229, 50001.74999124981, 50309.49690503048, 50385.0, 50623.74688126536, 44162.0, 44392.55607443949, 45041.0, 45238.77380613076, 45473.772631136635, 8180.959095204724, 8216.137305582828, 8219.589020548829, 8320.875186872081, 8330.750077497685, 33004.0, 33688.83155584305, 33906.83046584751, 34185.658143418244, 34393.140171495914, 40563.0, 41607.167856643304, 43475.78262108669, 43565.78217108894, 43684.78157609192, 9482.099200575934, 9624.855627165738, 9655.517224138905, 9677.419354838732, 9773.07155820196, 10201.004274886789, 10418.322809017389, 10437.58249670035, 10451.425171615634, 10453.843192352273, 9807.313488055768, 9854.162396196403, 9858.55636496345, 10126.898731012596, 10154.289199755945, 9827.0, 9870.358426702242, 10035.54840032215, 10059.245556583432, 10241.334313269614, 7600.771976840703, 10118.19054475655, 10255.897441025494, 10322.845157322796, 10577.889321621427, 8394.118617545315, 8404.0, 8404.474023485169, 8523.82952340962, 9059.592318345558, 8678.392512524062, 8937.551658550652, 9051.54742262871, 9084.091590841128, 9099.090090990849], "unit": "score", "name": "yui.html", "value": 5886.0830978177055}], "name": "dromaeo_css", "value": 6673.979999624652}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 109.0, 109.0, 110.0, 101.0, 112.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 152.0, 171.0, 126.0, 153.0, 152.0, 127.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 163.0, 162.0, 162.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 106.0, 91.0, 74.0, 72.0, 72.0, 117.0, 95.0, 71.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [104.0, 95.0, 136.0, 95.0, 96.0, 95.0, 144.0, 96.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 108.0, 109.0, 108.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 144.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 82.0, 81.0, 81.0, 81.0, 83.0, 81.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 123.0, 116.0, 116.0, 124.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [149.0, 145.0, 148.0, 141.0, 135.0, 131.0, 142.0, 142.0, 144.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 68.0, 66.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1491.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1947.4708171206225], "unit": "score", "name": "RayTrace", "value": 379.9743716283718}, {"lowerIsBetter": false, "replicates": [769.2307692307693], "unit": "score", "name": "Earley", "value": 866.4018999999997}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [43083.333333333336], "unit": "score", "name": "RegExp", "value": 21.144719535783352}, {"lowerIsBetter": false, "replicates": [607.6178960096735], "unit": "score", "name": "Splay", "value": 134.11553631840803}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18918.816120173215}]} 06:00:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18918.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1492.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6673.98"}}} 06:00:43 INFO - Return code: 0 06:00:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:00:43 INFO - # TBPL SUCCESS # 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - Running post-run listener: _resource_record_post_run 06:00:44 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 57344; Write bytes: 307863552; Read time: 80; Write time: 265848 06:00:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4009984; Read time: 0; Write time: 204 06:00:44 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 57344; Write bytes: 303853568; Read time: 80; Write time: 265644 06:00:44 INFO - Running post-run listener: _upload_blobber_files 06:00:44 INFO - Blob upload gear active. 06:00:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:00:44 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 06:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:00:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:45 INFO - (blobuploader) - INFO - Done attempting. 06:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:46 INFO - (blobuploader) - INFO - Done attempting. 06:00:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:46 INFO - Return code: 0 06:00:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:00:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0df5e0f090fa1e144b33fffbe298d91607193a6182597ab4d571c094105c38eced85a0f9ced9f342cd9cc4c235634fed0d37b5107c544866587017c9904376c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f66e0b873c2731e49c4c7004598c3e99355a69efe094b20da5c7adae34634de3d678ced9bc44626dfb820b158870d5fec2b16824ebb4e8ad813279f8fcad308d"} 06:00:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:00:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:00:46 INFO - Contents: 06:00:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0df5e0f090fa1e144b33fffbe298d91607193a6182597ab4d571c094105c38eced85a0f9ced9f342cd9cc4c235634fed0d37b5107c544866587017c9904376c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f66e0b873c2731e49c4c7004598c3e99355a69efe094b20da5c7adae34634de3d678ced9bc44626dfb820b158870d5fec2b16824ebb4e8ad813279f8fcad308d"} 06:00:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:46 INFO - Copying logs to upload dir... 06:00:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:00:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.778691 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-16 06:00:46.683737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 06:00:46.689031) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0df5e0f090fa1e144b33fffbe298d91607193a6182597ab4d571c094105c38eced85a0f9ced9f342cd9cc4c235634fed0d37b5107c544866587017c9904376c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f66e0b873c2731e49c4c7004598c3e99355a69efe094b20da5c7adae34634de3d678ced9bc44626dfb820b158870d5fec2b16824ebb4e8ad813279f8fcad308d"} build_url:https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/ZHxMOLqVTfaOZXxdzqPhMw/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/Firefox/sha512/b0df5e0f090fa1e144b33fffbe298d91607193a6182597ab4d571c094105c38eced85a0f9ced9f342cd9cc4c235634fed0d37b5107c544866587017c9904376c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f66e0b873c2731e49c4c7004598c3e99355a69efe094b20da5c7adae34634de3d678ced9bc44626dfb820b158870d5fec2b16824ebb4e8ad813279f8fcad308d"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 06:00:46.770967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:00:46.771309) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452931273.930622-1122766597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:00:46.906824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 06:00:46.907121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 06:00:46.907370) ========= ========= Total master_lag: 0.40 =========