builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1450964545.14 results: success (0) buildid: 20151224030228 builduid: 21b02eebcf8a4b1fbc651ed18c12650b revision: 35b211eaad1fa828064514c547057e4400e24459 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.141840) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.142432) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.142925) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006435 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.199293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.199671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.316000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.316326) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.384080) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.384512) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.385041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.385439) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 05:42:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2015-12-24 05:42:26 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095956 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.518145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.518692) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021487 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.591040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:25.591630) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35b211eaad1fa828064514c547057e4400e24459 --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 35b211eaad1fa828064514c547057e4400e24459 --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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 05:42:26,287 truncating revision to first 12 chars 2015-12-24 05:42:26,287 Setting DEBUG logging. 2015-12-24 05:42:26,287 attempt 1/10 2015-12-24 05:42:26,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35b211eaad1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 05:42:26,830 unpacking tar archive at: mozilla-central-35b211eaad1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:26.428383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:26.428722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:26.445527) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:26.445911) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 05:42:26.446375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-24 05:42:26.446705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:27 INFO - MultiFileLogger online at 20151224 05:42:27 in /builds/slave/test-pgo 05:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:42:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:42:27 INFO - {'append_to_log': False, 05:42:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:42:27 INFO - 'blob_upload_branch': 'Firefox', 05:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:42:27 INFO - 'branch': 'Firefox', 05:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:27 INFO - 'config_files': ('talos/linux_config.py',), 05:42:27 INFO - 'default_actions': ('clobber', 05:42:27 INFO - 'read-buildbot-config', 05:42:27 INFO - 'download-and-extract', 05:42:27 INFO - 'populate-webroot', 05:42:27 INFO - 'create-virtualenv', 05:42:27 INFO - 'install', 05:42:27 INFO - 'run-tests'), 05:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:27 INFO - 'download_minidump_stackwalk': True, 05:42:27 INFO - 'download_symbols': 'ondemand', 05:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:27 INFO - 'installer_path': 'installer.exe', 05:42:27 INFO - 'log_level': 'info', 05:42:27 INFO - 'log_name': 'talos', 05:42:27 INFO - 'log_to_console': True, 05:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:27 INFO - 'opt_config_files': (), 05:42:27 INFO - 'pip_index': False, 05:42:27 INFO - 'sps_profile': False, 05:42:27 INFO - 'sps_profile_interval': 0, 05:42:27 INFO - 'suite': 'dromaeojs-e10s', 05:42:27 INFO - 'system_bits': '64', 05:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:27 INFO - 'title': 'talos-linux64-ix-062', 05:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:27 INFO - 'use_talos_json': True, 05:42:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:27 INFO - 'work_dir': 'build'} 05:42:27 INFO - ##### 05:42:27 INFO - ##### Running clobber step. 05:42:27 INFO - ##### 05:42:27 INFO - Running pre-action listener: _resource_record_pre_action 05:42:27 INFO - Running main action method: clobber 05:42:27 INFO - rmtree: /builds/slave/test-pgo/build 05:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:42:27 INFO - Running post-action listener: _resource_record_post_action 05:42:27 INFO - ##### 05:42:27 INFO - ##### Running read-buildbot-config step. 05:42:27 INFO - ##### 05:42:27 INFO - Running pre-action listener: _resource_record_pre_action 05:42:27 INFO - Running main action method: read_buildbot_config 05:42:27 INFO - Using buildbot properties: 05:42:27 INFO - { 05:42:27 INFO - "project": "", 05:42:27 INFO - "product": "firefox", 05:42:27 INFO - "script_repo_revision": "production", 05:42:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:42:27 INFO - "repository": "", 05:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:42:27 INFO - "buildid": "20151224030228", 05:42:27 INFO - "stage_platform": "linux64-pgo", 05:42:27 INFO - "basedir": "/builds/slave/test-pgo", 05:42:27 INFO - "nightly_build": "True", 05:42:27 INFO - "buildnumber": 593, 05:42:27 INFO - "slavename": "talos-linux64-ix-062", 05:42:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:42:27 INFO - "platform": "ubuntu64_hw", 05:42:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:42:27 INFO - "branch": "mozilla-central", 05:42:27 INFO - "repo_path": "mozilla-central", 05:42:27 INFO - "revision": "35b211eaad1fa828064514c547057e4400e24459", 05:42:27 INFO - "pgo_build": "True", 05:42:27 INFO - "builduid": "21b02eebcf8a4b1fbc651ed18c12650b", 05:42:27 INFO - "slavebuilddir": "test" 05:42:27 INFO - } 05:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:42:27 INFO - Running post-action listener: _resource_record_post_action 05:42:27 INFO - ##### 05:42:27 INFO - ##### Running download-and-extract step. 05:42:27 INFO - ##### 05:42:27 INFO - Running pre-action listener: _resource_record_pre_action 05:42:27 INFO - Running main action method: download_and_extract 05:42:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:27 INFO - https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/test_packages.json 05:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/test_packages.json 05:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:42:37 INFO - Downloaded 1302 bytes. 05:42:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:42:37 INFO - Using the following test package requirements: 05:42:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'jsshell-linux-x86_64.zip'], 05:42:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:37 INFO - https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:48 INFO - Downloaded 23180666 bytes. 05:42:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:42:49 INFO - Return code: 0 05:42:49 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:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:49 INFO - https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:51 INFO - Downloaded 23180666 bytes. 05:42:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:42:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:42:52 INFO - Return code: 0 05:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:52 INFO - https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:54 INFO - Downloaded 11132277 bytes. 05:42:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:42:54 INFO - Return code: 0 05:42: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:42:54 INFO - https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:42:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:42:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lSSpl49ZQnKAVH3wvGvb7A/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:42:55 INFO - Downloaded 54825314 bytes. 05:42:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:42:55 INFO - mkdir: /builds/slave/test-pgo/properties 05:42:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:42:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:42:55 INFO - Contents: 05:42:55 INFO - build_url:https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:42:55 INFO - Running post-action listener: _resource_record_post_action 05:42:55 INFO - Running post-action listener: set_extra_try_arguments 05:42:55 INFO - ##### 05:42:55 INFO - ##### Running populate-webroot step. 05:42:55 INFO - ##### 05:42:55 INFO - Running pre-action listener: _resource_record_pre_action 05:42:55 INFO - Running main action method: populate_webroot 05:42:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:55 INFO - '--tppagecycles', 05:42:55 INFO - '7'], 05:42:55 INFO - 'tests': ['tsvgm']}}, 05:42:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:42:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:42:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:42:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'tests': ['damp', 'tps']}, 05:42:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['damp', 'tps']}, 05:42:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:55 INFO - 'other': {'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'other_l64': {'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:42:55 INFO - 'ts_paint', 05:42:55 INFO - 'tpaint', 05:42:55 INFO - 'sessionrestore', 05:42:55 INFO - 'sessionrestore_no_auto_restore']}, 05:42:55 INFO - 'svgr': {'tests': ['tsvgx', 05:42:55 INFO - 'tsvgr_opacity', 05:42:55 INFO - 'tart', 05:42:55 INFO - 'tscrollx', 05:42:55 INFO - 'cart']}, 05:42:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['tsvgx', 05:42:55 INFO - 'tsvgr_opacity', 05:42:55 INFO - 'tart', 05:42:55 INFO - 'tscrollx', 05:42:55 INFO - 'cart']}, 05:42:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'tests': ['tp5o']}, 05:42:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'talos_options': ['--e10s'], 05:42:55 INFO - 'tests': ['tp5o']}, 05:42:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'talos_options': ['--xperf_path', 05:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:55 INFO - 'tests': ['tp5n']}, 05:42:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:55 INFO - 'talos_options': ['--e10s', 05:42:55 INFO - '--xperf_path', 05:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:55 INFO - 'tests': ['tp5n']}}, 05:42:55 INFO - 'talos.zip': {'path': '', 05:42:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:55 INFO - Running post-action listener: _resource_record_post_action 05:42:55 INFO - ##### 05:42:55 INFO - ##### Running create-virtualenv step. 05:42:55 INFO - ##### 05:42:55 INFO - Running pre-action listener: _resource_record_pre_action 05:42:55 INFO - Running main action method: create_virtualenv 05:42:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:42:55 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:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:55 INFO - Using real prefix '/usr' 05:42:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:42:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:58 INFO - Installing pip.................done. 05:42:58 INFO - Return code: 0 05:42:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:42:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:42:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:42:58 INFO - Using env: {'DISPLAY': ':0', 05:42:58 INFO - 'HOME': '/home/cltbld', 05:42:58 INFO - 'LANG': 'en_US.UTF-8', 05:42:58 INFO - 'LANGUAGE': 'en_US:en', 05:42:58 INFO - 'LOGNAME': 'cltbld', 05:42:58 INFO - 'MAIL': '/var/mail/cltbld', 05:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:58 INFO - 'MOZ_NO_REMOTE': '1', 05:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:58 INFO - 'NO_EM_RESTART': '1', 05:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:58 INFO - 'SHELL': '/bin/bash', 05:42:58 INFO - 'SHLVL': '1', 05:42:58 INFO - 'TERM': 'linux', 05:42:58 INFO - 'TMOUT': '86400', 05:42:58 INFO - 'USER': 'cltbld', 05:42:58 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:58 INFO - '_': '/tools/buildbot/bin/python'} 05:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:58 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:42:58 INFO - Cleaning up... 05:42:58 INFO - Return code: 0 05:42:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:42:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:42:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:42:58 INFO - Using env: {'DISPLAY': ':0', 05:42:58 INFO - 'HOME': '/home/cltbld', 05:42:58 INFO - 'LANG': 'en_US.UTF-8', 05:42:58 INFO - 'LANGUAGE': 'en_US:en', 05:42:58 INFO - 'LOGNAME': 'cltbld', 05:42:58 INFO - 'MAIL': '/var/mail/cltbld', 05:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:58 INFO - 'MOZ_NO_REMOTE': '1', 05:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:58 INFO - 'NO_EM_RESTART': '1', 05:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:42:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:42:58 INFO - 'SHELL': '/bin/bash', 05:42:58 INFO - 'SHLVL': '1', 05:42:58 INFO - 'TERM': 'linux', 05:42:58 INFO - 'TMOUT': '86400', 05:42:58 INFO - 'USER': 'cltbld', 05:42:58 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:58 INFO - '_': '/tools/buildbot/bin/python'} 05:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:58 INFO - Downloading/unpacking psutil>=0.7.1 05:42: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:42: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:42: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:42: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:42: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:42: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:43:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:00 INFO - Installing collected packages: psutil 05:43:00 INFO - Running setup.py install for psutil 05:43:00 INFO - building 'psutil._psutil_linux' extension 05:43:00 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:43:00 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:43:00 INFO - building 'psutil._psutil_posix' extension 05:43:00 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:43:00 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:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:00 INFO - Successfully installed psutil 05:43:00 INFO - Cleaning up... 05:43:00 INFO - Return code: 0 05:43:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43: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:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:00 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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:00 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:43:00 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:43:00 INFO - Using env: {'DISPLAY': ':0', 05:43:00 INFO - 'HOME': '/home/cltbld', 05:43:00 INFO - 'LANG': 'en_US.UTF-8', 05:43:00 INFO - 'LANGUAGE': 'en_US:en', 05:43:00 INFO - 'LOGNAME': 'cltbld', 05:43:00 INFO - 'MAIL': '/var/mail/cltbld', 05:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:00 INFO - 'MOZ_NO_REMOTE': '1', 05:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:00 INFO - 'NO_EM_RESTART': '1', 05:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:00 INFO - 'SHELL': '/bin/bash', 05:43:00 INFO - 'SHLVL': '1', 05:43:00 INFO - 'TERM': 'linux', 05:43:00 INFO - 'TMOUT': '86400', 05:43:00 INFO - 'USER': 'cltbld', 05:43:00 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:00 INFO - '_': '/tools/buildbot/bin/python'} 05:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:43:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:02 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:43:02 INFO - Installing collected packages: mozsystemmonitor 05:43:02 INFO - Running setup.py install for mozsystemmonitor 05:43:02 INFO - Successfully installed mozsystemmonitor 05:43:02 INFO - Cleaning up... 05:43:02 INFO - Return code: 0 05:43:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', '--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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:03 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:43:03 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:43:03 INFO - Using env: {'DISPLAY': ':0', 05:43:03 INFO - 'HOME': '/home/cltbld', 05:43:03 INFO - 'LANG': 'en_US.UTF-8', 05:43:03 INFO - 'LANGUAGE': 'en_US:en', 05:43:03 INFO - 'LOGNAME': 'cltbld', 05:43:03 INFO - 'MAIL': '/var/mail/cltbld', 05:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:03 INFO - 'MOZ_NO_REMOTE': '1', 05:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:03 INFO - 'NO_EM_RESTART': '1', 05:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:03 INFO - 'SHELL': '/bin/bash', 05:43:03 INFO - 'SHLVL': '1', 05:43:03 INFO - 'TERM': 'linux', 05:43:03 INFO - 'TMOUT': '86400', 05:43:03 INFO - 'USER': 'cltbld', 05:43:03 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:03 INFO - '_': '/tools/buildbot/bin/python'} 05:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:43:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - Downloading docopt-0.6.1.tar.gz 05:43:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:05 INFO - Running setup.py install for blobuploader 05:43:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:05 INFO - Running setup.py install for requests 05:43:06 INFO - Running setup.py install for docopt 05:43:06 INFO - Successfully installed blobuploader requests docopt 05:43:06 INFO - Cleaning up... 05:43:06 INFO - Return code: 0 05:43:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:06 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:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:06 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:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:06 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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:06 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:43:06 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:43:06 INFO - Using env: {'DISPLAY': ':0', 05:43:06 INFO - 'HOME': '/home/cltbld', 05:43:06 INFO - 'LANG': 'en_US.UTF-8', 05:43:06 INFO - 'LANGUAGE': 'en_US:en', 05:43:06 INFO - 'LOGNAME': 'cltbld', 05:43:06 INFO - 'MAIL': '/var/mail/cltbld', 05:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:06 INFO - 'MOZ_NO_REMOTE': '1', 05:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:06 INFO - 'NO_EM_RESTART': '1', 05:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:06 INFO - 'SHELL': '/bin/bash', 05:43:06 INFO - 'SHLVL': '1', 05:43:06 INFO - 'TERM': 'linux', 05:43:06 INFO - 'TMOUT': '86400', 05:43:06 INFO - 'USER': 'cltbld', 05:43:06 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:06 INFO - '_': '/tools/buildbot/bin/python'} 05:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:06 INFO - Running setup.py (path:/tmp/pip-PKksii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:06 INFO - Running setup.py (path:/tmp/pip-fu01RN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:06 INFO - Running setup.py (path:/tmp/pip-xuhGXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:06 INFO - Running setup.py (path:/tmp/pip-LHvkdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:06 INFO - Running setup.py (path:/tmp/pip-lx5VXm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:06 INFO - Running setup.py (path:/tmp/pip-ffpfzK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:06 INFO - Running setup.py (path:/tmp/pip-f1buLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:06 INFO - Running setup.py (path:/tmp/pip-D059ZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:07 INFO - Running setup.py (path:/tmp/pip-kNiDSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:07 INFO - Running setup.py (path:/tmp/pip-qfYtdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:07 INFO - Running setup.py (path:/tmp/pip-KX71Pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:07 INFO - Running setup.py (path:/tmp/pip-5QL9Mi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:07 INFO - Running setup.py (path:/tmp/pip-2vCDsc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:07 INFO - Running setup.py (path:/tmp/pip-RMA4Vz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:07 INFO - Running setup.py (path:/tmp/pip-WnFX2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:07 INFO - Running setup.py (path:/tmp/pip-nGVZaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:07 INFO - Running setup.py (path:/tmp/pip-4A_DQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:07 INFO - Running setup.py install for manifestparser 05:43:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:07 INFO - Running setup.py install for mozcrash 05:43:07 INFO - Running setup.py install for mozdebug 05:43:07 INFO - Running setup.py install for mozdevice 05:43:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for mozfile 05:43:08 INFO - Running setup.py install for mozhttpd 05:43:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for mozinfo 05:43:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for mozInstall 05:43:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for mozleak 05:43:08 INFO - Running setup.py install for mozlog 05:43:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for moznetwork 05:43:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:43:08 INFO - Running setup.py install for mozprocess 05:43:08 INFO - Running setup.py install for mozprofile 05:43:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:43:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:43:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:43:09 INFO - Running setup.py install for mozrunner 05:43:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:43:09 INFO - Running setup.py install for mozscreenshot 05:43:09 INFO - Running setup.py install for moztest 05:43:09 INFO - Running setup.py install for mozversion 05:43:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:09 INFO - Cleaning up... 05:43:09 INFO - Return code: 0 05:43:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43: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:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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', '-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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:09 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:43:09 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:43:09 INFO - Using env: {'DISPLAY': ':0', 05:43:09 INFO - 'HOME': '/home/cltbld', 05:43:09 INFO - 'LANG': 'en_US.UTF-8', 05:43:09 INFO - 'LANGUAGE': 'en_US:en', 05:43:09 INFO - 'LOGNAME': 'cltbld', 05:43:09 INFO - 'MAIL': '/var/mail/cltbld', 05:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:09 INFO - 'MOZ_NO_REMOTE': '1', 05:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:09 INFO - 'NO_EM_RESTART': '1', 05:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:09 INFO - 'SHELL': '/bin/bash', 05:43:09 INFO - 'SHLVL': '1', 05:43:09 INFO - 'TERM': 'linux', 05:43:09 INFO - 'TMOUT': '86400', 05:43:09 INFO - 'USER': 'cltbld', 05:43:09 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:09 INFO - '_': '/tools/buildbot/bin/python'} 05:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:09 INFO - Running setup.py (path:/tmp/pip-dG_3Q_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:09 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:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:09 INFO - Running setup.py (path:/tmp/pip-4gHpQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:09 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:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:09 INFO - Running setup.py (path:/tmp/pip-sPs9cO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:09 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:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:09 INFO - Running setup.py (path:/tmp/pip-QzjAsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:10 INFO - Running setup.py (path:/tmp/pip-swvHUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:10 INFO - Running setup.py (path:/tmp/pip-EpcOC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:10 INFO - Running setup.py (path:/tmp/pip-neVBcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:10 INFO - Running setup.py (path:/tmp/pip-bJ5hNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:10 INFO - Running setup.py (path:/tmp/pip-csCJ4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:10 INFO - Running setup.py (path:/tmp/pip-ZnEiK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:10 INFO - Running setup.py (path:/tmp/pip-vhXQHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:10 INFO - Running setup.py (path:/tmp/pip-UtgrCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:10 INFO - Running setup.py (path:/tmp/pip-Ztpoev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:10 INFO - Running setup.py (path:/tmp/pip-Pz80di-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:10 INFO - Running setup.py (path:/tmp/pip-YYEkzV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:10 INFO - Running setup.py (path:/tmp/pip-xb3c_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:10 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:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:10 INFO - Running setup.py (path:/tmp/pip-8Ij1v4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:10 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:43:10 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:43:10 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:43:10 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:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:43:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43: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:43: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:43: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:43: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:43: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:43: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:43:12 INFO - Downloading blessings-1.5.1.tar.gz 05:43:12 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:43:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:12 INFO - Installing collected packages: blessings 05:43:12 INFO - Running setup.py install for blessings 05:43:12 INFO - Successfully installed blessings 05:43:12 INFO - Cleaning up... 05:43:12 INFO - Return code: 0 05:43:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:43:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:13 INFO - Reading from file tmpfile_stdout 05:43:13 INFO - Current package versions: 05:43:13 INFO - argparse == 1.2.1 05:43:13 INFO - blessings == 1.5.1 05:43:13 INFO - blobuploader == 1.2.4 05:43:13 INFO - docopt == 0.6.1 05:43:13 INFO - manifestparser == 1.1 05:43:13 INFO - mozInstall == 1.12 05:43:13 INFO - mozcrash == 0.16 05:43:13 INFO - mozdebug == 0.1 05:43:13 INFO - mozdevice == 0.47 05:43:13 INFO - mozfile == 1.2 05:43:13 INFO - mozhttpd == 0.7 05:43:13 INFO - mozinfo == 0.9 05:43:13 INFO - mozleak == 0.1 05:43:13 INFO - mozlog == 3.1 05:43:13 INFO - moznetwork == 0.27 05:43:13 INFO - mozprocess == 0.22 05:43:13 INFO - mozprofile == 0.28 05:43:13 INFO - mozrunner == 6.11 05:43:13 INFO - mozscreenshot == 0.1 05:43:13 INFO - mozsystemmonitor == 0.0 05:43:13 INFO - moztest == 0.7 05:43:13 INFO - mozversion == 1.4 05:43:13 INFO - psutil == 3.1.1 05:43:13 INFO - requests == 1.2.3 05:43:13 INFO - wsgiref == 0.1.2 05:43:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:13 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:43:13 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:43:13 INFO - Using env: {'DISPLAY': ':0', 05:43:13 INFO - 'HOME': '/home/cltbld', 05:43:13 INFO - 'LANG': 'en_US.UTF-8', 05:43:13 INFO - 'LANGUAGE': 'en_US:en', 05:43:13 INFO - 'LOGNAME': 'cltbld', 05:43:13 INFO - 'MAIL': '/var/mail/cltbld', 05:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:13 INFO - 'MOZ_NO_REMOTE': '1', 05:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:13 INFO - 'NO_EM_RESTART': '1', 05:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:13 INFO - 'SHELL': '/bin/bash', 05:43:13 INFO - 'SHLVL': '1', 05:43:13 INFO - 'TERM': 'linux', 05:43:13 INFO - 'TMOUT': '86400', 05:43:13 INFO - 'USER': 'cltbld', 05:43:13 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:13 INFO - '_': '/tools/buildbot/bin/python'} 05:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 INFO - Cleaning up... 05:43:13 INFO - Return code: 0 05:43:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 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 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:13 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:43:13 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:43:13 INFO - Using env: {'DISPLAY': ':0', 05:43:13 INFO - 'HOME': '/home/cltbld', 05:43:13 INFO - 'LANG': 'en_US.UTF-8', 05:43:13 INFO - 'LANGUAGE': 'en_US:en', 05:43:13 INFO - 'LOGNAME': 'cltbld', 05:43:13 INFO - 'MAIL': '/var/mail/cltbld', 05:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:13 INFO - 'MOZ_NO_REMOTE': '1', 05:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:13 INFO - 'NO_EM_RESTART': '1', 05:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:13 INFO - 'SHELL': '/bin/bash', 05:43:13 INFO - 'SHLVL': '1', 05:43:13 INFO - 'TERM': 'linux', 05:43:13 INFO - 'TMOUT': '86400', 05:43:13 INFO - 'USER': 'cltbld', 05:43:13 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:13 INFO - '_': '/tools/buildbot/bin/python'} 05:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:13 INFO - Downloading/unpacking jsonschema 05:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:13 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:43:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:15 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:43:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:15 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:43:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:15 INFO - warning: no files found matching '*.txt' 05:43:15 INFO - no previously-included directories found matching 'build' 05:43:15 INFO - no previously-included directories found matching 'dist' 05:43:15 INFO - no previously-included directories found matching '.git*' 05:43:15 INFO - Installing collected packages: jsonschema, functools32 05:43:15 INFO - Running setup.py install for functools32 05:43:15 INFO - warning: no files found matching '*.txt' 05:43:15 INFO - no previously-included directories found matching 'build' 05:43:15 INFO - no previously-included directories found matching 'dist' 05:43:15 INFO - no previously-included directories found matching '.git*' 05:43:15 INFO - Successfully installed jsonschema functools32 05:43:15 INFO - Cleaning up... 05:43:15 INFO - Return code: 0 05:43:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6188d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c31480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', '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:43:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:43:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:43:15 INFO - Using env: {'DISPLAY': ':0', 05:43:15 INFO - 'HOME': '/home/cltbld', 05:43:15 INFO - 'LANG': 'en_US.UTF-8', 05:43:15 INFO - 'LANGUAGE': 'en_US:en', 05:43:15 INFO - 'LOGNAME': 'cltbld', 05:43:15 INFO - 'MAIL': '/var/mail/cltbld', 05:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:15 INFO - 'MOZ_NO_REMOTE': '1', 05:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:15 INFO - 'NO_EM_RESTART': '1', 05:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:15 INFO - 'SHELL': '/bin/bash', 05:43:15 INFO - 'SHLVL': '1', 05:43:15 INFO - 'TERM': 'linux', 05:43:15 INFO - 'TMOUT': '86400', 05:43:15 INFO - 'USER': 'cltbld', 05:43:15 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:15 INFO - '_': '/tools/buildbot/bin/python'} 05:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:15 INFO - Downloading/unpacking flake8 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:43:17 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:43:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:43:17 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:43:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:17 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:43:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:43:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:18 INFO - no previously-included directories found matching 'docs/_build' 05:43:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:43:18 INFO - Running setup.py install for pep8 05:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:18 INFO - no previously-included directories found matching 'docs/_build' 05:43:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:43:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:43:18 INFO - Cleaning up... 05:43:18 INFO - Return code: 0 05:43:18 INFO - Running post-action listener: _resource_record_post_action 05:43:18 INFO - Running post-action listener: _start_resource_monitoring 05:43:18 INFO - Starting resource monitoring. 05:43:18 INFO - ##### 05:43:18 INFO - ##### Running install step. 05:43:18 INFO - ##### 05:43:18 INFO - Running pre-action listener: _resource_record_pre_action 05:43:18 INFO - Running main action method: install 05:43:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:18 INFO - Reading from file tmpfile_stdout 05:43:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:43:18 INFO - Reading from file tmpfile_stdout 05:43:18 INFO - Output received: 05:43:18 INFO - Usage: mozinstall [options] installer 05:43:18 INFO - Options: 05:43:18 INFO - -h, --help show this help message and exit 05:43:18 INFO - -d DEST, --destination=DEST 05:43:18 INFO - Directory to install application into. [default: 05:43:18 INFO - "/builds/slave/test-pgo"] 05:43:18 INFO - --app=APP Application being installed. [default: firefox] 05:43:18 INFO - mkdir: /builds/slave/test-pgo/build/application 05:43:18 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:43:18 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:43:34 INFO - Reading from file tmpfile_stdout 05:43:34 INFO - Output received: 05:43:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:43:34 INFO - Running post-action listener: _resource_record_post_action 05:43:34 INFO - ##### 05:43:34 INFO - ##### Running run-tests step. 05:43:34 INFO - ##### 05:43:34 INFO - Running pre-action listener: _resource_record_pre_action 05:43:34 INFO - Running main action method: run_tests 05:43:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:43:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:43:34 INFO - Python 2.7.3 05:43:34 INFO - Return code: 0 05:43:34 INFO - grabbing minidump binary from tooltool 05:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:34 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 0x2cc0660>, '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 0x2cc1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:43:34 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:43:34 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:43:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:34 INFO - Return code: 0 05:43:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:43:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:43:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:43:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:43:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:43:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:43:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:43:35 INFO - Return code: 0 05:43:35 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:43:35 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:43:35 INFO - Using env: {'DISPLAY': ':0', 05:43:35 INFO - 'HOME': '/home/cltbld', 05:43:35 INFO - 'LANG': 'en_US.UTF-8', 05:43:35 INFO - 'LANGUAGE': 'en_US:en', 05:43:35 INFO - 'LOGNAME': 'cltbld', 05:43:35 INFO - 'MAIL': '/var/mail/cltbld', 05:43:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:43:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:35 INFO - 'MOZ_NO_REMOTE': '1', 05:43:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:35 INFO - 'NO_EM_RESTART': '1', 05:43:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:43:35 INFO - 'SHELL': '/bin/bash', 05:43:35 INFO - 'SHLVL': '1', 05:43:35 INFO - 'TERM': 'linux', 05:43:35 INFO - 'TMOUT': '86400', 05:43:35 INFO - 'USER': 'cltbld', 05:43:35 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101', 05:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:35 INFO - '_': '/tools/buildbot/bin/python'} 05:43:35 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:43:35 INFO - mozversion application_buildid: 20151224030228 05:43:35 INFO - mozversion application_changeset: 35b211eaad1fa828064514c547057e4400e24459 05:43:35 INFO - mozversion application_display_name: Nightly 05:43:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:35 INFO - mozversion application_name: Firefox 05:43:35 INFO - mozversion application_remotingname: firefox 05:43:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:43:35 INFO - mozversion application_vendor: Mozilla 05:43:35 INFO - mozversion application_version: 46.0a1 05:43:35 INFO - mozversion platform_buildid: 20151224030228 05:43:35 INFO - mozversion platform_changeset: 35b211eaad1fa828064514c547057e4400e24459 05:43:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:43:35 INFO - mozversion platform_version: 46.0a1 05:43:35 INFO - using testdate: 1450964615 05:43:35 INFO - actual date: 1450964615 05:43:35 INFO - starting webserver on 'localhost:44176' 05:43:35 INFO - SUITE-START | Running 3 tests 05:43:35 INFO - TEST-START | dromaeo_css 05:43:35 INFO - operating with platform_type : linux_ 05:43:35 INFO - Initialising browser for dromaeo_css test... 05:43:35 INFO - TEST-INFO | started process 26161 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR_czal/profile http://localhost:44176/getInfo.html) 05:43:40 INFO - PROCESS | 26161 | __metrics Screen width/height:1600/1200 05:43:40 INFO - PROCESS | 26161 | colorDepth:24 05:43:40 INFO - PROCESS | 26161 | Browser inner width/height: 1024/670 05:43:40 INFO - PROCESS | 26161 | __metrics 05:43:40 INFO - PROCESS | 26161 | 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:43:41 INFO - TEST-INFO | 26161: exit 0 05:43:41 INFO - Browser initialized. 05:43:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:41 INFO - TEST-INFO | started process 26294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR_czal/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:53 INFO - PROCESS | 26294 | RSS: Main: 151777280 05:43:53 INFO - PROCESS | 26294 | 05:44:42 INFO - PROCESS | 26294 | 1450964682812 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:46:51 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44176/tests/dromaeo/cssquery-ext.html) 05:46:52 INFO - PROCESS | 26294 | RSS: Main: 157134848 05:46:52 INFO - PROCESS | 26294 | 05:49:54 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-ext.html (next: http://localhost:44176/tests/dromaeo/cssquery-jquery.html) 05:49:54 INFO - PROCESS | 26294 | RSS: Main: 153075712 05:49:54 INFO - PROCESS | 26294 | 05:52:56 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44176/tests/dromaeo/cssquery-mootools.html) 05:52:57 INFO - PROCESS | 26294 | RSS: Main: 153563136 05:52:57 INFO - PROCESS | 26294 | 05:55:58 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44176/tests/dromaeo/cssquery-prototype.html) 05:55:59 INFO - PROCESS | 26294 | RSS: Main: 152629248 05:55:59 INFO - PROCESS | 26294 | 05:59:01 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44176/tests/dromaeo/cssquery-yui.html) 05:59:02 INFO - PROCESS | 26294 | RSS: Main: 151990272 05:59:02 INFO - PROCESS | 26294 | 06:02:04 INFO - PROCESS | 26294 | Cycle 1(1): loaded http://localhost:44176/tests/dromaeo/cssquery-yui.html (next: http://localhost:44176/tests/dromaeo/cssquery-dojo.html) 06:02:05 INFO - PROCESS | 26294 | RSS: Main: 154873856 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | __start_tp_report 06:02:05 INFO - PROCESS | 26294 | _x_x_mozilla_page_load 06:02:05 INFO - PROCESS | 26294 | _x_x_mozilla_page_load_details 06:02:05 INFO - PROCESS | 26294 | |i|pagename|runs| 06:02:05 INFO - PROCESS | 26294 | |0;dojo.html;3111.859966301516;3173.0322251713233;3187.0438868339493;3202.647708752037;3217.5012873004694;5121.052605268028;5269.367675878891;5281.5246627803535;5287.762050707718;5313.548348390386;5167.9224811627855;5189.299444574981;5210.583153347732;5243.213517972306;5459.836204913849;4688.929666055012;4732.124556956956;4797.7840997155035;4798.736069516175;4878.975605121969;4888.975555122237;4910.1652719037675;4921.458639549646;4964.032013757319;4988.575971042465;4693.06138772247;4720.07958448101;4830.9371938173545;4836.081144582518;4839.395075615548;4787.832425865078;4880.902381952341;4888.02239552091;4899.951000490021;4929.359183306183;4642.35007099003;4869.634777391674;4900.950990490085;4904.386951631046;4958.925616115761;4966.47851975541;5002.699838009731;5053.140966035783;5068.72122033288;5109.591232701375;5732.398098199671;5751.1085781703905;5772;5775.566832487538;5782.10377391505;5635.971820140914;5761.827145185651;5790.334111577138;5816.476517113438;5877.05967045275;5287.603429742746;5318.25544423781;5332.626716129873;5336.599755018312;5369.543588794957;5750.942490575041;5827.067669172912;5829.067349224104;5831.096180092092;5833;5454.209139674725;5570.721463926788;5599.636023658449;5606.915896261559;5608.803691870765;5767.625104368202;5773.480386765212;5773.769049237983;5796.565257605696;5800.477956983807;5657.43425657431;5667.263255776723;5731.369549349568;5733.512651424592;5734.971325143348;5385.353757549119;5614.07367784311;5615.326160860723;5641.379448260688;5748.02283611787;4383.342498625232;4395.978020109879;4398.186335527937;4408.625266852289;4411;3891.8443262269193;3918.1380096378753;3927.351986922183;3933.0364060805286;3966.900827479336;5177.016366890279;5294.12646913255;5322.38792538863;5402.702851343214;5436.945630543723;5573.804916827891;5582.162675598693;5600.215969764236;5614.831555053355;5675.120356344773;5247.527722504993;5257.185136303879;5282.788688452496;5290.074237008585;5300.178472336794;4744.857654270378;4822.7829747661435;4854.19905715553;4871.488493708181;5005.324281221989;5877.294724633071;5930.169776231331;5938.198343223609;5953.970230148821;5964.970175149097;5777;5796.0436527972415;5800.4489573490455;5814.622049566765;5821.185034095145;5765.56758243125;5767.077267637158;5795.072788353843;5913.083472061838;5954.196183515343;5600.243967064394;5646.3506696728755;5660.405657406078;5666.490015898589;5677.261955945701;5639.661620302795;5703.8859222816145;5704.80033198836;5708.686022268815;5723.8569035774435;5300.1519756838725;5404;5496.862578435571;5619.241402410622;5664.8300550981885;5507.5593952482905;5532.944670553404;5557;5576.275084239185;5578.442155784552;5366.382865970463;5422.15956526739;5533.750981205775;5536.335639723259;5595.048841697003;5382.946170538245;5524;5534.1975413564005;5578.2748242728185;5633.887322253614;5420.05149098914;5441.5102640762525;5476.151196564539;5478.479544443271;5492.395836457907 06:02:05 INFO - PROCESS | 26294 | |1;ext.html;556.2240674259408;565.6295126692017;578.4967078641582;578.7424596054755;609.2780055634071;34603.48094778577;34799.47800782987;35041.64958350416;35297.11757206071;35358.46962295564;36633;36639.267214655694;36691.4496282556;36702.26595468096;36783.4482482763;8379.32965362771;8586.09845966174;8588.527630980294;8593.441426307301;8601.354898382615;8096.959515202416;8214.301784348338;8231.094579596269;8266.586670666473;8279.586020698971;8245.876311855327;8255.174482551756;8255.95872020639;8285.047219569766;8354.707585234519;8204.917950820474;8214.548199849007;8256.917430825704;8261.752147435587;8294.8341033179;8165.510069395856;8197.098319184885;8254.669813207465;8256.25693687571;8308.584570771498;34015.489767653504;34574.308513829834;34649.65350346489;34651.306973860635;34776.130596735034;2721.523733346676;2779.166250124975;2780.666320041588;2813.817101888371;2861.155958992102;28719.28201794951;28854.278643033882;29151.41697166045;29186.70813291861;29262.268443288875;3901.9219615607813;3946.3883098119836;4018.3168861293357;4061.6547593454593;4096.180763847243;266676;272012;272636;274418;275398.62300688366;39887;54169;54864.9999999992;54928.450715492334;54987.72506137444;40588.39117413241;40791.7960410196;40890.386644200364;41127.383089253686;41130.79434602808;12902.161359511601;12975.610731678065;13083.08418410721;13132.277724725232;13147.802782958262;9850.50747462624;9901.257405694601;9901.75245618851;9902.851457228147;9928.702138935843;13586.456541738418;13881.722365552834;13888.375023123781;13934.094283871718;13992.720145597032;5646.57650676201;5656.264685590929;5670.291213598301;5740.799072032459;5746.224259724883;867.5878957495139;870.8432482153273;880.4145243413059;887.0995939121797;985.7338518599938;29632;31043.84478077595;31097.53353699696;31204.219894502367;31883.202919926724;973.2432365535562;973.6640858903809;997.6209040564539;1011.6661501704419;1074.5272080284649;13751.381187846571;13909.095908765898;14136.15183089018;14259;14392.784108238386;393057;399724;400932;401839;403259;49445.752771235915;49597.50402496001;49605;49858;49875.75062124666;1254.29759334771;1254.6988722706667;1256.9874301257237;1259.8110283457372;1345.488714288564;25678.871605641853;26727;26895.058672946354;26962.32594185161;27098.593521097595;41817;41854;42114;42179;42386.152276953675;291493;291686;291789;292629;294716;29793;42281.57718422776;43327.35008974931;43697.78151109224;43947;37906.43140352952;38477;38537.421938671505;38680.6131938677;39178.2164356717;28328.43343133167;28967.565486518142;35535;39193.608063919;39907.40138897861;32511.512327314635;32830.507542387364;32876.342473149925;33007.33985320328;33121.668783311856;27112.864435677697;27156.72843271542;27699.58450623202;27704.58443123395;27759;25115.74884251134;26137.869310653325;26429.207123786317;26561.203163905113;27055.72944270532;23490.412739681644;23824.642630360904;23956.40108997289;24215.273541793773;24329.75670243275 06:02:05 INFO - PROCESS | 26294 | |2;jquery.html;348.5277449056527;350.58630815637537;353.64988661225397;356.4386091905249;358.19942428671914;16083;17161.742573861404;17478.825211747877;18089.90955045223;18694.15876285565;15681;15721.764173537405;15856.207189640501;15908.920455397707;16236.350545978146;5016.498350164981;5122.103631864427;5175.301334319875;5204.037253108168;5205.37535495741;4436.889077773066;5104.5405913467785;5127.9743601282125;5138.897222055557;5145.0481660892665;5442.727863606804;5451.182322651614;5460.563154947615;5479.123340265558;5488.643238189525;5369.650972686783;5402.675839449606;5458.4814442627885;5466.699331536764;5487.725613719338;4917.286993385975;4943.134951383529;4961.08219979305;4968.130577149021;4984.426790919055;14000;19573.902130489256;19806.603867922706;19833.702494462595;20435;1971.5662554238045;2057.444489987695;2094.8114669679803;2106.220698341608;2130.5206328575946;9603.32776705631;9825.656102036395;9980.101790838859;12103.092268079841;12610.243385396905;1788.937387191442;1793.7399077133873;1801.1534578748099;1827.4974382044911;1833.431636192771;61496.69251653758;62250.68874655598;63401.74781523096;63516.68241658808;64464.35535644631;9966.651167209113;9990.750231244278;10300.896991029993;10353.844692329621;10362.533685984148;12631.810522842165;13071.346432678329;13074.346282685829;13090.934545327213;13626.523071692443;5954.07711804671;6060.303065147476;6731.798046058626;7394.112706475257;7484.663190156456;7028.332308430691;7058.9294107059295;7074.6816393262425;7192.100987376578;7207.351338379466;4342.82628694855;4386.035072284092;4397.824087036547;4413.713108647928;4415.359772832985;1857.619188066443;1865.123392005755;1870.9064546772606;1892.9242830286635;1896.1088288504382;808.4219782855287;869.426178722053;875.2210532625968;895.0378343280998;895.5969813583913;16696.582585435463;16771.83228167727;16793.412230572114;16853.747193792104;17130.657386852192;863.1023735315327;924.385283786288;927.79124696944;932.2821427500922;948.4735971535725;9614.51927403627;9768.36505627132;9771.657991970247;9781.364211326383;9808.313418060667;492640;495602;501955;530711;535889;76970;79525.60237198892;81455.59272203602;81699;81742.59128704437;1121.955121795119;1132.0547342968548;1162.1690491298762;1188.0495603517152;1188.2929656854158;15719.371225151323;15983.280752366403;16000.199990000687;16013.279402426686;16086.43697470583;32077.67922320747;34982.825085875425;35828.82085589555;36106.09734756652;36471;42454;42809;44119.55880441283;47145.764271179796;47694;9605.759856003655;9668.951655241679;9691.370060946016;9862.704118876445;9944.45305508204;16198.433054843024;16573.91713041427;16815.159242037604;17034.914825425793;17189.31242750326;13844.653883652989;14286.499972501328;14372.353244103831;14500.057496262709;14582.635434113809;14117;14542.41830326775;14892.478763243234;14995.10029398196;15122.168280744665;13354.732905341645;14284.57146285613;14333.918207585419;14424.495142669955;14616.634584135481;9151.542422878696;9157.221636161;9265.583048762686;9394.67118650844;9440.905590944003;13743.793843092162;13943.16341019542;13944.16335019902;13999.53004934508;14311.57065288043 06:02:05 INFO - PROCESS | 26294 | |3;mootools.html;1482.3625840888415;1535.2016951185383;1593.3148746039199;1608.3003893306409;1625.528596706955;7028.61342626156;7194.96402517988;7269.345758881706;7308.159561650412;7450.776476705694;7275.963620181905;7329.853402931938;7341.77974660761;7416.7774966751085;7417.147028091771;2190.0582749417786;2231.665250212473;2239.2722365231284;2245.382519807058;2248.055816557042;2219.4673278413147;2246.4496198431407;2255.612798129155;2257.2889539794996;2263.219189379661;2128.467883029243;2178.2267295110246;2184.552166805809;2188.5951099046647;2211.8672879627193;2176.5646870625937;2210.8673479591275;2225;2244.7755224477587;2252.718410198725;2111.1133324003954;2121.5650791587686;2128.5636444528836;2142.721446211998;2144.1852096203497;7288.4169266459085;7379.741709040211;7382.261773822628;7383.48315617907;7385.963070184668;4393.648508119343;4433.977830110861;4459.420275364214;4460.375547423363;4464.843730469451;2946.4107178564373;2965.3624470738896;2973.3458639099363;2983.0752466735166;3011.9247018824485;973.1922504321396;993.3692105512979;995.5470261031213;1007.8639383683255;1076.3219171921717;9516.904830951671;9546.188573971222;9572.856407153899;9617.27870409722;9691.51542422876;3799.069228039148;3829.195868867513;3925.0776067624083;3930.449737036817;3972.860949866799;7776.144624091346;7806.92193078062;7808.258215469521;7818.179091195457;7825;4140.730852494638;4155.667546596265;4162.542120366757;4170.416141740159;4175.916481670411;3810.3522401191863;3837.7910958048124;3856.382978723391;3881.844726210976;3888.1446081861945;3236.6116066072223;3245.496947973068;3257.9185520361707;3265.232670322472;3283.244853683666;1007.959681612742;1042.6819819954987;1048.4128887822844;1049.0244073012173;1053.7892421515728;953.0231512699538;957.3107362698846;1002.674130907458;1008.8234558952154;1179.8761130081389;6611;6619.304972977864;6647.933520664731;6679.599224046573;6714.429273511709;1035.9119474844572;1036.8444733290066;1039.6880935719255;1044.7074819050679;1054.3041592548882;5267.947320526822;5280.762365693553;5287.9735601321745;5290.841274761763;5295.258663787073;8466.40735148546;8497.957510212409;8549.829003419896;8617.78455538604;8630.223279904712;8522.57387130641;8546.572671366406;8562.357823163287;8589.957050214834;8610.655573777103;6499.675016249169;6614.7023383947835;6625.701843417058;6695.230048544382;6766.526343156031;6660.933390666031;6680.665966701743;6687;6701.32986701326;6705.497087718343;7685.385169186564;7785.844283114193;7865.882011769942;7880.211978802074;7907.011623547057;7884.960575197088;8013.398995075276;8039.879401809095;8060.83878322442;8084.393670474856;5892.35184129754;6514.4788416925585;6541.6075035496115;6545.509086818603;6568.310327415744;6783.796486105425;6807.829804254933;6825.453963682993;6836.077129587442;6855.862882742417;6277;6334.90497642545;6365.809025729235;6509.414152726277;6523.054157147092;6387.489000879826;6393.6163830170335;6416.582922110048;6454.806355809334;6488.578242414228;6436.903446448214;6505;6509.544331896722;6523.445507131947;6575.901361479678;5921.644701317935;5967.671778052075;5978.940210597838;5994.850128746816;6026.578139530191;6042.5770196087615;6067.666278354733;6081.908771368345;6098.26820781509;6110.847228819315 06:02:05 INFO - PROCESS | 26294 | |4;prototype.html;332.7038935347541;334.0379706445437;339.1690358621375;342.7446552318522;344.95170676105334;6274.686265686714;6298.464630506401;6351.777687780928;6387.329330420309;6468.902966455507;6318.715657795398;6334.683265836713;6336;6344.460720838734;6345;4747.52524747526;4777.784999675023;4799.328094066834;4810.494898035691;4832.9275060874115;4793.257045158006;4798.208295631217;4803.231482962727;4820.517948205186;4832.806687732504;4685.83599574015;4738.881527961811;4744.383230180072;4771.832985845496;4779.80880764769;4766.571008609207;4773.80904763809;4779.187538118528;4783.689060211075;4788.449328327235;4124.587541245882;4154.4183814265725;4162.542120366757;4166.687498437629;4173.728707633994;6013.428724271187;6027.126066720301;6037.094435834616;6045;6045.486133678643;5477.972610136924;5599.832005039855;5605;5614.073677843151;5622.128570071604;6705.195376554796;6709.630970296632;6732.057511948331;6742.359475849787;6746.93253067468;4566.520515345907;4570.862874113782;4577.702449340783;4598.517155698637;4619.330197121399;6741.224759152711;6921.1002569666125;6929.341712537301;6943.062686537354;7045.788626341269;4591.081783643284;4619.976900115478;4649.279361698942;4659.20793465105;4660.743659098782;4722.6221902247735;4724.71651700899;4734.952650473451;4735.621150307967;4738.31294462308;5471.945280547223;5479.205515200274;5490.615656904059;5507.256520369699;5515.917261241085;6571.178602674666;6692.096566963398;6725.865482690417;6729.528932974645;6760.830979225559;1628.9266982985557;1660.9916950415413;1667.5247554446923;1668.215938508899;1672.6821903838231;1082.6156714366286;1084.7830433913248;1105.3147048829617;1123.2530367305812;1127.7913585986455;6089.786857460056;6148.569600127948;6188.226471691039;6195.16365290689;6215.564910456315;6729.764458243938;6733.3266673333255;6766.18805743314;6782.966085169642;6793;6071.605345652519;6166.506679465632;6199.597026193283;6202.906956395657;6203.689815509207;3711.4989476420337;3731.832067556912;3735.850565977385;3736.9439458408146;3737.663610275034;7065.505414620927;7069.116360454943;7104.040954471184;7122.323379278961;7143.464240182007;6782.541753523016;6993.685284162225;7006.054182685272;7010.859782804316;7020.894686579705;7037.859242815218;7072.151341839012;7090;7094.219635840053;7100.076989991268;6819.181698196248;6855.725770969305;6856.760013399507;6859.828504287433;6872.209695885037;6680.3987641112535;6753.1220941277315;6830.180378354629;6834.726610935507;6861.622610756456;6999.860002800017;7013.894791578233;7102;7108.715651373887;7131.215566287808;4655.953440465688;4656.208444564364;4656.720596764205;4671.252599584051;4705.458872229738;6767.593944363354;6841.760538381132;6861.519693621598;6872;6955.339242771928;6769.289224631343;6788.626625535643;6812.216595091628;6830.180378354629;6858.142732158481;6772.8486157354355;6791.320867913169;6801;6802.183737951477;6802.217744959393;6510.7721229756735;6604.702788374439;6606.966965165144;6607.80176594703;6654.168228971379;6767.796966091025;6807.217170025312;6812.591244525344;6817;6822.556533825285;6622.437092847162;6641.302663220292;6654.367835055662;6670.699818508276;6678.165229346332 06:02:05 INFO - PROCESS | 26294 | |5;yui.html;651.9413252807246;674.8852695041844;715.6529083394554;774.643663914599;778.256764789626;13130.803037954427;13313.334333283321;13340.332983350841;13374.933125334372;13436.52972145975;12111;12263.202891812027;12297.323647199422;12308.323042232674;12330.136890417674;593.5874567175792;604.1059232336145;700.2087640965701;707.4729326651639;736.4991805572208;712.0956385390551;728.6538894025349;728.7485817392991;732.4177279063158;734.3794493652881;751.4026349052516;759.3242014607005;768.7194174126431;771.6836097200149;771.9768406947801;752.9962350188241;755.5126943121684;762.8512440074188;763.8854171874235;766.5170942306312;557.5511713070977;561.8146011816132;562.9014922388566;563.3296377311028;563.7857614106613;12014.759704805942;12159.93920030403;12208.877911220863;12227.877721222763;12270.32513211773;11289.943550282278;11795.469203885847;12061.33662648554;12082.33547154906;12158.939205303917;10405.531751071145;10408.115310198642;10571.94714026425;10663.413512256822;10720.624778132727;3622.2393297407575;3634.1641422472717;3656.287024030315;3701.648343407372;3722.3671975764187;46756.53243467556;46875.5312446878;46888.531114688754;47099.29351059737;47302.763486182695;9780.804383912424;9987.800243995225;10133;10195.413748841596;10405.895941040493;16670.99948006247;16788.6642267154;16792.580185495215;16863;16867.831321686626;6864.279250678607;6890.8621827563165;7124.216336203013;7203.89194162088;7657.310842024244;4186.727862688916;4254.936175957363;4268.786560671954;4279.186954478639;4337.436133302651;2727.7681397081074;2730.071775596307;2745.1490038088255;2750.422411293651;2754.5730411786203;513.9229115632685;525.5952916254463;526.5603221310172;527.209186220669;527.4962410897583;620.2030390947701;652.8628987912497;653.2683394597985;654.4404534123256;702.7891632510226;9358.251339892928;9434.528273586431;9660.516974151264;9736.172425343784;9996.300258981946;501.503511523589;619.6189343553682;630.2657404124144;652.5138771615177;652.8270008447765;4127.690423218271;4212.747235165839;4241.893952651147;4384.320430333303;4451.910961780811;50904.490955089976;51700.74149629228;52552.21171682428;53138;54968;49018.26472602914;50250.74874625603;50387.49612503901;50395;50874;43252.567474325486;43511.78244108759;44079.33880991788;44805.10389792186;45158.32262516065;8861.867071994055;8923.41997770143;9113.179813816789;9138.17756401927;9252.676156334495;32719.836400818796;33094.510747016924;33485.16287092842;33857.83071084629;34677.91932484059;42159.36760948527;42160;42212.366814497196;43149.352759709254;43472.56527434685;9815.165710914653;10217.897821021694;10628.946855265674;10727.570897164025;10740.785184296426;12122.992362763645;12141.332226727614;12175.817362739388;12260.877391225973;12379.62861114168;9667.9033209667;9818.116369526777;9921.25590580695;10281.422522778701;10742.462876856282;11411.201215914807;11486.655400338002;11626.883731162918;11701.531938722695;11836.526538938346;11293;11399.20205585601;11596.478158483058;11644.76710465769;11710.765784684088;9021.909780902108;9212.493312867857;9282.489463079595;9540.570674319533;10017.54921028541;9116.817663646823;9463.952680236554;9804.1666458349;9835.803283934138;9936.701898943043 06:02:05 INFO - PROCESS | 26294 | __end_tp_report 06:02:05 INFO - PROCESS | 26294 | __start_cc_report 06:02:05 INFO - PROCESS | 26294 | _x_x_mozilla_cycle_collect,305 06:02:05 INFO - PROCESS | 26294 | __end_cc_report 06:02:05 INFO - PROCESS | 26294 | __startTimestamp1450965725035__endTimestamp 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | ------- Summary: start ------- 06:02:05 INFO - PROCESS | 26294 | Number of tests: 6 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#0] dojo.html Cycles:165 Average:5277.11 Median:5454.21 stddev:590.19 (10.8%) stddev-sans-first:567.03 06:02:05 INFO - PROCESS | 26294 | Values: 3111.9 3173.0 3187.0 3202.6 3217.5 5121.1 5269.4 5281.5 5287.8 5313.5 5167.9 5189.3 5210.6 5243.2 5459.8 4688.9 4732.1 4797.8 4798.7 4879.0 4889.0 4910.2 4921.5 4964.0 4988.6 4693.1 4720.1 4830.9 4836.1 4839.4 4787.8 4880.9 4888.0 4900.0 4929.4 4642.4 4869.6 4901.0 4904.4 4958.9 4966.5 5002.7 5053.1 5068.7 5109.6 5732.4 5751.1 5772.0 5775.6 5782.1 5636.0 5761.8 5790.3 5816.5 5877.1 5287.6 5318.3 5332.6 5336.6 5369.5 5750.9 5827.1 5829.1 5831.1 5833.0 5454.2 5570.7 5599.6 5606.9 5608.8 5767.6 5773.5 5773.8 5796.6 5800.5 5657.4 5667.3 5731.4 5733.5 5735.0 5385.4 5614.1 5615.3 5641.4 5748.0 4383.3 4396.0 4398.2 4408.6 4411.0 3891.8 3918.1 3927.4 3933.0 3966.9 5177.0 5294.1 5322.4 5402.7 5436.9 5573.8 5582.2 5600.2 5614.8 5675.1 5247.5 5257.2 5282.8 5290.1 5300.2 4744.9 4822.8 4854.2 4871.5 5005.3 5877.3 5930.2 5938.2 5954.0 5965.0 5777.0 5796.0 5800.4 5814.6 5821.2 5765.6 5767.1 5795.1 5913.1 5954.2 5600.2 5646.4 5660.4 5666.5 5677.3 5639.7 5703.9 5704.8 5708.7 5723.9 5300.2 5404.0 5496.9 5619.2 5664.8 5507.6 5532.9 5557.0 5576.3 5578.4 5366.4 5422.2 5533.8 5536.3 5595.0 5382.9 5524.0 5534.2 5578.3 5633.9 5420.1 5441.5 5476.2 5478.5 5492.4 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#1] ext.html Cycles:180 Average:46516.45 Median:37344.94 stddev:86039.78 (230.4%) stddev-sans-first:86211.94 06:02:05 INFO - PROCESS | 26294 | Values: 556.2 565.6 578.5 578.7 609.3 34603.5 34799.5 35041.6 35297.1 35358.5 36633.0 36639.3 36691.4 36702.3 36783.4 8379.3 8586.1 8588.5 8593.4 8601.4 8097.0 8214.3 8231.1 8266.6 8279.6 8245.9 8255.2 8256.0 8285.0 8354.7 8204.9 8214.5 8256.9 8261.8 8294.8 8165.5 8197.1 8254.7 8256.3 8308.6 34015.5 34574.3 34649.7 34651.3 34776.1 2721.5 2779.2 2780.7 2813.8 2861.2 28719.3 28854.3 29151.4 29186.7 29262.3 3901.9 3946.4 4018.3 4061.7 4096.2 266676.0 272012.0 272636.0 274418.0 275398.6 39887.0 54169.0 54865.0 54928.5 54987.7 40588.4 40791.8 40890.4 41127.4 41130.8 12902.2 12975.6 13083.1 13132.3 13147.8 9850.5 9901.3 9901.8 9902.9 9928.7 13586.5 13881.7 13888.4 13934.1 13992.7 5646.6 5656.3 5670.3 5740.8 5746.2 867.6 870.8 880.4 887.1 985.7 29632.0 31043.8 31097.5 31204.2 31883.2 973.2 973.7 997.6 1011.7 1074.5 13751.4 13909.1 14136.2 14259.0 14392.8 393057.0 399724.0 400932.0 401839.0 403259.0 49445.8 49597.5 49605.0 49858.0 49875.8 1254.3 1254.7 1257.0 1259.8 1345.5 25678.9 26727.0 26895.1 26962.3 27098.6 41817.0 41854.0 42114.0 42179.0 42386.2 291493.0 291686.0 291789.0 292629.0 294716.0 29793.0 42281.6 43327.4 43697.8 43947.0 37906.4 38477.0 38537.4 38680.6 39178.2 28328.4 28967.6 35535.0 39193.6 39907.4 32511.5 32830.5 32876.3 33007.3 33121.7 27112.9 27156.7 27699.6 27704.6 27759.0 25115.7 26137.9 26429.2 26561.2 27055.7 23490.4 23824.6 23956.4 24215.3 24329.8 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#2] jquery.html Cycles:180 Average:28047.50 Median:42631.50 stddev:83676.67 (196.3%) stddev-sans-first:83885.56 06:02:05 INFO - PROCESS | 26294 | Values: 348.5 350.6 353.6 356.4 358.2 16083.0 17161.7 17478.8 18089.9 18694.2 15681.0 15721.8 15856.2 15908.9 16236.4 5016.5 5122.1 5175.3 5204.0 5205.4 4436.9 5104.5 5128.0 5138.9 5145.0 5442.7 5451.2 5460.6 5479.1 5488.6 5369.7 5402.7 5458.5 5466.7 5487.7 4917.3 4943.1 4961.1 4968.1 4984.4 14000.0 19573.9 19806.6 19833.7 20435.0 1971.6 2057.4 2094.8 2106.2 2130.5 9603.3 9825.7 9980.1 12103.1 12610.2 1788.9 1793.7 1801.2 1827.5 1833.4 61496.7 62250.7 63401.7 63516.7 64464.4 9966.7 9990.8 10300.9 10353.8 10362.5 12631.8 13071.3 13074.3 13090.9 13626.5 5954.1 6060.3 6731.8 7394.1 7484.7 7028.3 7058.9 7074.7 7192.1 7207.4 4342.8 4386.0 4397.8 4413.7 4415.4 1857.6 1865.1 1870.9 1892.9 1896.1 808.4 869.4 875.2 895.0 895.6 16696.6 16771.8 16793.4 16853.7 17130.7 863.1 924.4 927.8 932.3 948.5 9614.5 9768.4 9771.7 9781.4 9808.3 492640.0 495602.0 501955.0 530711.0 535889.0 76970.0 79525.6 81455.6 81699.0 81742.6 1122.0 1132.1 1162.2 1188.0 1188.3 15719.4 15983.3 16000.2 16013.3 16086.4 32077.7 34982.8 35828.8 36106.1 36471.0 42454.0 42809.0 44119.6 47145.8 47694.0 9605.8 9669.0 9691.4 9862.7 9944.5 16198.4 16573.9 16815.2 17034.9 17189.3 13844.7 14286.5 14372.4 14500.1 14582.6 14117.0 14542.4 14892.5 14995.1 15122.2 13354.7 14284.6 14333.9 14424.5 14616.6 9151.5 9157.2 9265.6 9394.7 9440.9 13743.8 13943.2 13944.2 13999.5 14311.6 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#3] mootools.html Cycles:180 Average:5041.67 Median:6193.92 stddev:2559.12 (41.3%) stddev-sans-first:2552.32 06:02:05 INFO - PROCESS | 26294 | Values: 1482.4 1535.2 1593.3 1608.3 1625.5 7028.6 7195.0 7269.3 7308.2 7450.8 7276.0 7329.9 7341.8 7416.8 7417.1 2190.1 2231.7 2239.3 2245.4 2248.1 2219.5 2246.4 2255.6 2257.3 2263.2 2128.5 2178.2 2184.6 2188.6 2211.9 2176.6 2210.9 2225.0 2244.8 2252.7 2111.1 2121.6 2128.6 2142.7 2144.2 7288.4 7379.7 7382.3 7383.5 7386.0 4393.6 4434.0 4459.4 4460.4 4464.8 2946.4 2965.4 2973.3 2983.1 3011.9 973.2 993.4 995.5 1007.9 1076.3 9516.9 9546.2 9572.9 9617.3 9691.5 3799.1 3829.2 3925.1 3930.4 3972.9 7776.1 7806.9 7808.3 7818.2 7825.0 4140.7 4155.7 4162.5 4170.4 4175.9 3810.4 3837.8 3856.4 3881.8 3888.1 3236.6 3245.5 3257.9 3265.2 3283.2 1008.0 1042.7 1048.4 1049.0 1053.8 953.0 957.3 1002.7 1008.8 1179.9 6611.0 6619.3 6647.9 6679.6 6714.4 1035.9 1036.8 1039.7 1044.7 1054.3 5267.9 5280.8 5288.0 5290.8 5295.3 8466.4 8498.0 8549.8 8617.8 8630.2 8522.6 8546.6 8562.4 8590.0 8610.7 6499.7 6614.7 6625.7 6695.2 6766.5 6660.9 6680.7 6687.0 6701.3 6705.5 7685.4 7785.8 7865.9 7880.2 7907.0 7885.0 8013.4 8039.9 8060.8 8084.4 5892.4 6514.5 6541.6 6545.5 6568.3 6783.8 6807.8 6825.5 6836.1 6855.9 6277.0 6334.9 6365.8 6509.4 6523.1 6387.5 6393.6 6416.6 6454.8 6488.6 6436.9 6505.0 6509.5 6523.4 6575.9 5921.6 5967.7 5978.9 5994.9 6026.6 6042.6 6067.7 6081.9 6098.3 6110.8 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#4] prototype.html Cycles:180 Average:5565.48 Median:6286.58 stddev:1690.14 (26.9%) stddev-sans-first:1648.62 06:02:05 INFO - PROCESS | 26294 | Values: 332.7 334.0 339.2 342.7 345.0 6274.7 6298.5 6351.8 6387.3 6468.9 6318.7 6334.7 6336.0 6344.5 6345.0 4747.5 4777.8 4799.3 4810.5 4832.9 4793.3 4798.2 4803.2 4820.5 4832.8 4685.8 4738.9 4744.4 4771.8 4779.8 4766.6 4773.8 4779.2 4783.7 4788.4 4124.6 4154.4 4162.5 4166.7 4173.7 6013.4 6027.1 6037.1 6045.0 6045.5 5478.0 5599.8 5605.0 5614.1 5622.1 6705.2 6709.6 6732.1 6742.4 6746.9 4566.5 4570.9 4577.7 4598.5 4619.3 6741.2 6921.1 6929.3 6943.1 7045.8 4591.1 4620.0 4649.3 4659.2 4660.7 4722.6 4724.7 4735.0 4735.6 4738.3 5471.9 5479.2 5490.6 5507.3 5515.9 6571.2 6692.1 6725.9 6729.5 6760.8 1628.9 1661.0 1667.5 1668.2 1672.7 1082.6 1084.8 1105.3 1123.3 1127.8 6089.8 6148.6 6188.2 6195.2 6215.6 6729.8 6733.3 6766.2 6783.0 6793.0 6071.6 6166.5 6199.6 6202.9 6203.7 3711.5 3731.8 3735.9 3736.9 3737.7 7065.5 7069.1 7104.0 7122.3 7143.5 6782.5 6993.7 7006.1 7010.9 7020.9 7037.9 7072.2 7090.0 7094.2 7100.1 6819.2 6855.7 6856.8 6859.8 6872.2 6680.4 6753.1 6830.2 6834.7 6861.6 6999.9 7013.9 7102.0 7108.7 7131.2 4656.0 4656.2 4656.7 4671.3 4705.5 6767.6 6841.8 6861.5 6872.0 6955.3 6769.3 6788.6 6812.2 6830.2 6858.1 6772.8 6791.3 6801.0 6802.2 6802.2 6510.8 6604.7 6607.0 6607.8 6654.2 6767.8 6807.2 6812.6 6817.0 6822.6 6622.4 6641.3 6654.4 6670.7 6678.2 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - PROCESS | 26294 | [#5] yui.html Cycles:180 Average:13304.97 Median:46816.03 stddev:15165.34 (32.4%) stddev-sans-first:15178.12 06:02:05 INFO - PROCESS | 26294 | Values: 651.9 674.9 715.7 774.6 778.3 13130.8 13313.3 13340.3 13374.9 13436.5 12111.0 12263.2 12297.3 12308.3 12330.1 593.6 604.1 700.2 707.5 736.5 712.1 728.7 728.7 732.4 734.4 751.4 759.3 768.7 771.7 772.0 753.0 755.5 762.9 763.9 766.5 557.6 561.8 562.9 563.3 563.8 12014.8 12159.9 12208.9 12227.9 12270.3 11289.9 11795.5 12061.3 12082.3 12158.9 10405.5 10408.1 10571.9 10663.4 10720.6 3622.2 3634.2 3656.3 3701.6 3722.4 46756.5 46875.5 46888.5 47099.3 47302.8 9780.8 9987.8 10133.0 10195.4 10405.9 16671.0 16788.7 16792.6 16863.0 16867.8 6864.3 6890.9 7124.2 7203.9 7657.3 4186.7 4254.9 4268.8 4279.2 4337.4 2727.8 2730.1 2745.1 2750.4 2754.6 513.9 525.6 526.6 527.2 527.5 620.2 652.9 653.3 654.4 702.8 9358.3 9434.5 9660.5 9736.2 9996.3 501.5 619.6 630.3 652.5 652.8 4127.7 4212.7 4241.9 4384.3 4451.9 50904.5 51700.7 52552.2 53138.0 54968.0 49018.3 50250.7 50387.5 50395.0 50874.0 43252.6 43511.8 44079.3 44805.1 45158.3 8861.9 8923.4 9113.2 9138.2 9252.7 32719.8 33094.5 33485.2 33857.8 34677.9 42159.4 42160.0 42212.4 43149.4 43472.6 9815.2 10217.9 10628.9 10727.6 10740.8 12123.0 12141.3 12175.8 12260.9 12379.6 9667.9 9818.1 9921.3 10281.4 10742.5 11411.2 11486.7 11626.9 11701.5 11836.5 11293.0 11399.2 11596.5 11644.8 11710.8 9021.9 9212.5 9282.5 9540.6 10017.5 9116.8 9464.0 9804.2 9835.8 9936.7 06:02:05 INFO - PROCESS | 26294 | -------- Summary: end -------- 06:02:05 INFO - PROCESS | 26294 | 06:02:05 INFO - TEST-INFO | 26294: exit 0 06:02:05 INFO - TEST-OK | dromaeo_css | took 1109938ms 06:02:05 INFO - TEST-START | kraken 06:02:05 INFO - operating with platform_type : linux_ 06:02:05 INFO - Initialising browser for kraken test... 06:02:05 INFO - TEST-INFO | started process 26537 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTcNbSm/profile http://localhost:44176/getInfo.html) 06:02:10 INFO - PROCESS | 26537 | __metrics Screen width/height:1600/1200 06:02:10 INFO - PROCESS | 26537 | colorDepth:24 06:02:10 INFO - PROCESS | 26537 | Browser inner width/height: 1024/670 06:02:10 INFO - PROCESS | 26537 | __metrics 06:02:10 INFO - PROCESS | 26537 | 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:02:11 INFO - TEST-INFO | 26537: exit 0 06:02:11 INFO - Browser initialized. 06:02:11 INFO - Running cycle 1/1 for kraken test... 06:02:11 INFO - TEST-INFO | started process 26660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTcNbSm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:22 INFO - PROCESS | 26660 | RSS: Main: 150892544 06:02:22 INFO - PROCESS | 26660 | 06:02:25 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44176/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:25 INFO - PROCESS | 26660 | RSS: Main: 151474176 06:02:25 INFO - PROCESS | 26660 | 06:02:28 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44176/tests/kraken/driver.html?testName=audio-dft) 06:02:29 INFO - PROCESS | 26660 | RSS: Main: 152113152 06:02:29 INFO - PROCESS | 26660 | 06:02:32 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44176/tests/kraken/driver.html?testName=audio-fft) 06:02:32 INFO - PROCESS | 26660 | RSS: Main: 144633856 06:02:32 INFO - PROCESS | 26660 | 06:02:34 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44176/tests/kraken/driver.html?testName=audio-oscillator) 06:02:35 INFO - PROCESS | 26660 | RSS: Main: 146169856 06:02:35 INFO - PROCESS | 26660 | 06:02:37 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44176/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:38 INFO - PROCESS | 26660 | RSS: Main: 146976768 06:02:38 INFO - PROCESS | 26660 | 06:02:41 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44176/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:41 INFO - PROCESS | 26660 | RSS: Main: 147079168 06:02:41 INFO - PROCESS | 26660 | 06:02:45 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44176/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:45 INFO - PROCESS | 26660 | RSS: Main: 148393984 06:02:45 INFO - PROCESS | 26660 | 06:02:48 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44176/tests/kraken/driver.html?testName=json-parse-financial) 06:02:49 INFO - PROCESS | 26660 | RSS: Main: 148717568 06:02:49 INFO - PROCESS | 26660 | 06:02:50 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44176/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:51 INFO - PROCESS | 26660 | RSS: Main: 148172800 06:02:51 INFO - PROCESS | 26660 | 06:02:53 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:53 INFO - PROCESS | 26660 | RSS: Main: 148873216 06:02:53 INFO - PROCESS | 26660 | 06:02:56 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:56 INFO - PROCESS | 26660 | RSS: Main: 148578304 06:02:56 INFO - PROCESS | 26660 | 06:02:59 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:59 INFO - PROCESS | 26660 | RSS: Main: 149139456 06:02:59 INFO - PROCESS | 26660 | 06:03:02 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:02 INFO - PROCESS | 26660 | RSS: Main: 148725760 06:03:02 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | Cycle 1(1): loaded http://localhost:44176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44176/tests/kraken/driver.html?testName=ai-astar) 06:03:04 INFO - PROCESS | 26660 | RSS: Main: 148541440 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | __start_tp_report 06:03:04 INFO - PROCESS | 26660 | _x_x_mozilla_page_load 06:03:04 INFO - PROCESS | 26660 | _x_x_mozilla_page_load_details 06:03:04 INFO - PROCESS | 26660 | |i|pagename|runs| 06:03:04 INFO - PROCESS | 26660 | |0;ai-astar;112;108;115;114;116;124;114;113;112;112 06:03:04 INFO - PROCESS | 26660 | |1;audio-beat-detection;156;128;157;164;127;156;150;140;168;126 06:03:04 INFO - PROCESS | 26660 | |2;audio-dft;163;164;162;162;164;163;165;174;165;162 06:03:04 INFO - PROCESS | 26660 | |3;audio-fft;74;72;75;71;73;134;73;78;73;74 06:03:04 INFO - PROCESS | 26660 | |4;audio-oscillator;94;94;136;95;94;95;135;94;94;140 06:03:04 INFO - PROCESS | 26660 | |5;imaging-gaussian-blur;113;113;110;111;110;110;111;111;111;111 06:03:04 INFO - PROCESS | 26660 | |6;imaging-darkroom;147;148;147;147;147;148;149;147;147;147 06:03:04 INFO - PROCESS | 26660 | |7;imaging-desaturate;97;97;97;98;97;96;98;97;97;97 06:03:04 INFO - PROCESS | 26660 | |8;json-parse-financial;62;63;65;66;64;63;64;62;59;61 06:03:04 INFO - PROCESS | 26660 | |9;json-stringify-tinderbox;69;70;70;70;69;69;69;69;69;70 06:03:04 INFO - PROCESS | 26660 | |10;stanford-crypto-aes;93;89;85;88;87;93;87;87;96;86 06:03:04 INFO - PROCESS | 26660 | |11;stanford-crypto-ccm;119;122;125;127;116;118;128;126;136;128 06:03:04 INFO - PROCESS | 26660 | |12;stanford-crypto-pbkdf2;143;155;155;164;155;143;159;156;158;145 06:03:04 INFO - PROCESS | 26660 | |13;stanford-crypto-sha256-iterative;71;69;69;70;71;70;69;71;71;70 06:03:04 INFO - PROCESS | 26660 | __end_tp_report 06:03:04 INFO - PROCESS | 26660 | __start_cc_report 06:03:04 INFO - PROCESS | 26660 | _x_x_mozilla_cycle_collect,733 06:03:04 INFO - PROCESS | 26660 | __end_cc_report 06:03:04 INFO - PROCESS | 26660 | __startTimestamp1450965784886__endTimestamp 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | ------- Summary: start ------- 06:03:04 INFO - PROCESS | 26660 | Number of tests: 14 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:4.14 (3.6%) stddev-sans-first:4.32 06:03:04 INFO - PROCESS | 26660 | Values: 112.0 108.0 115.0 114.0 116.0 124.0 114.0 113.0 112.0 112.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:156.00 stddev:15.82 (10.1%) stddev-sans-first:16.45 06:03:04 INFO - PROCESS | 26660 | Values: 156.0 128.0 157.0 164.0 127.0 156.0 150.0 140.0 168.0 126.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.57 (2.2%) stddev-sans-first:3.75 06:03:04 INFO - PROCESS | 26660 | Values: 163.0 164.0 162.0 162.0 164.0 163.0 165.0 174.0 165.0 162.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#3] audio-fft Cycles:10 Average:79.70 Median:73.50 stddev:19.17 (26.1%) stddev-sans-first:20.22 06:03:04 INFO - PROCESS | 26660 | Values: 74.0 72.0 75.0 71.0 73.0 134.0 73.0 78.0 73.0 74.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:20.67 (22.0%) stddev-sans-first:21.38 06:03:04 INFO - PROCESS | 26660 | Values: 94.0 94.0 136.0 95.0 94.0 95.0 135.0 94.0 94.0 140.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:111.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 06:03:04 INFO - PROCESS | 26660 | Values: 113.0 113.0 110.0 111.0 110.0 110.0 111.0 111.0 111.0 111.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:03:04 INFO - PROCESS | 26660 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 149.0 147.0 147.0 147.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:03:04 INFO - PROCESS | 26660 | Values: 97.0 97.0 97.0 98.0 97.0 96.0 98.0 97.0 97.0 97.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.50 stddev:2.02 (3.2%) stddev-sans-first:2.12 06:03:04 INFO - PROCESS | 26660 | Values: 62.0 63.0 65.0 66.0 64.0 63.0 64.0 62.0 59.0 61.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 06:03:04 INFO - PROCESS | 26660 | Values: 69.0 70.0 70.0 70.0 69.0 69.0 69.0 69.0 69.0 70.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:88.50 stddev:3.63 (4.1%) stddev-sans-first:3.57 06:03:04 INFO - PROCESS | 26660 | Values: 93.0 89.0 85.0 88.0 87.0 93.0 87.0 87.0 96.0 86.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:5.93 (4.7%) stddev-sans-first:5.95 06:03:04 INFO - PROCESS | 26660 | Values: 119.0 122.0 125.0 127.0 116.0 118.0 128.0 126.0 136.0 128.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:155.50 stddev:7.20 (4.6%) stddev-sans-first:6.60 06:03:04 INFO - PROCESS | 26660 | Values: 143.0 155.0 155.0 164.0 155.0 143.0 159.0 156.0 158.0 145.0 06:03:04 INFO - PROCESS | 26660 | 06:03:04 INFO - PROCESS | 26660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:0.88 (1.2%) stddev-sans-first:0.87 06:03:04 INFO - PROCESS | 26660 | Values: 71.0 69.0 69.0 70.0 71.0 70.0 69.0 71.0 71.0 70.0 06:03:04 INFO - PROCESS | 26660 | -------- Summary: end -------- 06:03:04 INFO - PROCESS | 26660 | 06:03:05 INFO - TEST-INFO | 26660: exit 0 06:03:05 INFO - TEST-OK | kraken | took 60125ms 06:03:05 INFO - TEST-START | v8_7 06:03:05 INFO - operating with platform_type : linux_ 06:03:05 INFO - Initialising browser for v8_7 test... 06:03:05 INFO - TEST-INFO | started process 26944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1c2laV/profile http://localhost:44176/getInfo.html) 06:03:10 INFO - PROCESS | 26944 | __metrics Screen width/height:1600/1200 06:03:10 INFO - PROCESS | 26944 | colorDepth:24 06:03:10 INFO - PROCESS | 26944 | Browser inner width/height: 1024/670 06:03:10 INFO - PROCESS | 26944 | __metrics 06:03:10 INFO - PROCESS | 26944 | 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:03:11 INFO - TEST-INFO | 26944: exit 0 06:03:11 INFO - Browser initialized. 06:03:11 INFO - Running cycle 1/1 for v8_7 test... 06:03:11 INFO - TEST-INFO | started process 27066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1c2laV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:22 INFO - PROCESS | 27066 | RSS: Main: 150863872 06:03:22 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | Cycle 1(1): loaded http://localhost:44176/tests/v8_7/run.html (next: http://localhost:44176/tests/v8_7/run.html) 06:03:44 INFO - PROCESS | 27066 | RSS: Main: 146632704 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | __start_tp_report 06:03:44 INFO - PROCESS | 27066 | _x_x_mozilla_page_load 06:03:44 INFO - PROCESS | 27066 | _x_x_mozilla_page_load_details 06:03:44 INFO - PROCESS | 27066 | |i|pagename|runs| 06:03:44 INFO - PROCESS | 27066 | |0;Richards;168.97600540723218 06:03:44 INFO - PROCESS | 27066 | |1;DeltaBlue;187.6172607879925 06:03:44 INFO - PROCESS | 27066 | |2;Encrypt;280.1120448179272 06:03:44 INFO - PROCESS | 27066 | |3;Decrypt;5202.072538860104 06:03:44 INFO - PROCESS | 27066 | |4;RayTrace;1042.752867570386 06:03:44 INFO - PROCESS | 27066 | |5;Earley;722.543352601156 06:03:44 INFO - PROCESS | 27066 | |6;Boyer;12195.121951219513 06:03:44 INFO - PROCESS | 27066 | |7;RegExp;24926.829268292684 06:03:44 INFO - PROCESS | 27066 | |8;Splay;737.656595431098 06:03:44 INFO - PROCESS | 27066 | |9;NavierStokes;4864.077669902913 06:03:44 INFO - PROCESS | 27066 | __end_tp_report 06:03:44 INFO - PROCESS | 27066 | __startTimestamp1450965824666__endTimestamp 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | ------- Summary: start ------- 06:03:44 INFO - PROCESS | 27066 | Number of tests: 10 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#0] Richards Cycles:1 Average:168.98 Median:168.98 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 169.0 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#1] DeltaBlue Cycles:1 Average:187.62 Median:187.62 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 187.6 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 280.1 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 5202.1 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#4] RayTrace Cycles:1 Average:1042.75 Median:1042.75 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 1042.8 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#5] Earley Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 722.5 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 12195.1 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 24926.8 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#8] Splay Cycles:1 Average:737.66 Median:737.66 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 737.7 06:03:44 INFO - PROCESS | 27066 | 06:03:44 INFO - PROCESS | 27066 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 06:03:44 INFO - PROCESS | 27066 | Values: 4864.1 06:03:44 INFO - PROCESS | 27066 | -------- Summary: end -------- 06:03:44 INFO - PROCESS | 27066 | 06:03:45 INFO - TEST-INFO | 27066: exit 0 06:03:45 INFO - TEST-OK | v8_7 | took 39652ms 06:03:45 INFO - SUITE-END | took 1209s 06:03:45 INFO - Completed test suite (00:20:09) 06:03:45 INFO - Working with test: dromaeo_css 06:03:45 INFO - Generating results file: dromaeo_css 06:03:45 INFO - Working with test: kraken 06:03:45 INFO - Generating results file: kraken 06:03:45 INFO - javascript benchmark 06:03:45 INFO - Working with test: v8_7 06:03:45 INFO - Generating results file: v8_7 06:03:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:03:45 INFO - process_Request line: dromaeo_css 6801.65 graph.html#tests=[[72,1,43]] 06:03:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:45 INFO - process_Request line: kraken 1537.30 graph.html#tests=[[232,1,43]] 06:03:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:46 INFO - process_Request line: v8_7 20967.49 graph.html#tests=[[230,1,43]] 06:03:46 INFO - RETURN: dromaeo_css: 6801.65 06:03:46 INFO - RETURN: kraken: 1537.30 06:03:46 INFO - RETURN: v8_7: 20967.49 06:03:46 INFO - javascript benchmark 06:03:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3111.859966301516, 3173.0322251713233, 3187.0438868339493, 3202.647708752037, 3217.5012873004694, 5121.052605268028, 5269.367675878891, 5281.5246627803535, 5287.762050707718, 5313.548348390386, 5167.9224811627855, 5189.299444574981, 5210.583153347732, 5243.213517972306, 5459.836204913849, 4688.929666055012, 4732.124556956956, 4797.7840997155035, 4798.736069516175, 4878.975605121969, 4888.975555122237, 4910.1652719037675, 4921.458639549646, 4964.032013757319, 4988.575971042465, 4693.06138772247, 4720.07958448101, 4830.9371938173545, 4836.081144582518, 4839.395075615548, 4787.832425865078, 4880.902381952341, 4888.02239552091, 4899.951000490021, 4929.359183306183, 4642.35007099003, 4869.634777391674, 4900.950990490085, 4904.386951631046, 4958.925616115761, 4966.47851975541, 5002.699838009731, 5053.140966035783, 5068.72122033288, 5109.591232701375, 5732.398098199671, 5751.1085781703905, 5772.0, 5775.566832487538, 5782.10377391505, 5635.971820140914, 5761.827145185651, 5790.334111577138, 5816.476517113438, 5877.05967045275, 5287.603429742746, 5318.25544423781, 5332.626716129873, 5336.599755018312, 5369.543588794957, 5750.942490575041, 5827.067669172912, 5829.067349224104, 5831.096180092092, 5833.0, 5454.209139674725, 5570.721463926788, 5599.636023658449, 5606.915896261559, 5608.803691870765, 5767.625104368202, 5773.480386765212, 5773.769049237983, 5796.565257605696, 5800.477956983807, 5657.43425657431, 5667.263255776723, 5731.369549349568, 5733.512651424592, 5734.971325143348, 5385.353757549119, 5614.07367784311, 5615.326160860723, 5641.379448260688, 5748.02283611787, 4383.342498625232, 4395.978020109879, 4398.186335527937, 4408.625266852289, 4411.0, 3891.8443262269193, 3918.1380096378753, 3927.351986922183, 3933.0364060805286, 3966.900827479336, 5177.016366890279, 5294.12646913255, 5322.38792538863, 5402.702851343214, 5436.945630543723, 5573.804916827891, 5582.162675598693, 5600.215969764236, 5614.831555053355, 5675.120356344773, 5247.527722504993, 5257.185136303879, 5282.788688452496, 5290.074237008585, 5300.178472336794, 4744.857654270378, 4822.7829747661435, 4854.19905715553, 4871.488493708181, 5005.324281221989, 5877.294724633071, 5930.169776231331, 5938.198343223609, 5953.970230148821, 5964.970175149097, 5777.0, 5796.0436527972415, 5800.4489573490455, 5814.622049566765, 5821.185034095145, 5765.56758243125, 5767.077267637158, 5795.072788353843, 5913.083472061838, 5954.196183515343, 5600.243967064394, 5646.3506696728755, 5660.405657406078, 5666.490015898589, 5677.261955945701, 5639.661620302795, 5703.8859222816145, 5704.80033198836, 5708.686022268815, 5723.8569035774435, 5300.1519756838725, 5404.0, 5496.862578435571, 5619.241402410622, 5664.8300550981885, 5507.5593952482905, 5532.944670553404, 5557.0, 5576.275084239185, 5578.442155784552, 5366.382865970463, 5422.15956526739, 5533.750981205775, 5536.335639723259, 5595.048841697003, 5382.946170538245, 5524.0, 5534.1975413564005, 5578.2748242728185, 5633.887322253614, 5420.05149098914, 5441.5102640762525, 5476.151196564539, 5478.479544443271, 5492.395836457907], "unit": "score", "name": "dojo.html", "value": 5238.9213017926995}, {"lowerIsBetter": false, "replicates": [556.2240674259408, 565.6295126692017, 578.4967078641582, 578.7424596054755, 609.2780055634071, 34603.48094778577, 34799.47800782987, 35041.64958350416, 35297.11757206071, 35358.46962295564, 36633.0, 36639.267214655694, 36691.4496282556, 36702.26595468096, 36783.4482482763, 8379.32965362771, 8586.09845966174, 8588.527630980294, 8593.441426307301, 8601.354898382615, 8096.959515202416, 8214.301784348338, 8231.094579596269, 8266.586670666473, 8279.586020698971, 8245.876311855327, 8255.174482551756, 8255.95872020639, 8285.047219569766, 8354.707585234519, 8204.917950820474, 8214.548199849007, 8256.917430825704, 8261.752147435587, 8294.8341033179, 8165.510069395856, 8197.098319184885, 8254.669813207465, 8256.25693687571, 8308.584570771498, 34015.489767653504, 34574.308513829834, 34649.65350346489, 34651.306973860635, 34776.130596735034, 2721.523733346676, 2779.166250124975, 2780.666320041588, 2813.817101888371, 2861.155958992102, 28719.28201794951, 28854.278643033882, 29151.41697166045, 29186.70813291861, 29262.268443288875, 3901.9219615607813, 3946.3883098119836, 4018.3168861293357, 4061.6547593454593, 4096.180763847243, 266676.0, 272012.0, 272636.0, 274418.0, 275398.62300688366, 39887.0, 54169.0, 54864.9999999992, 54928.450715492334, 54987.72506137444, 40588.39117413241, 40791.7960410196, 40890.386644200364, 41127.383089253686, 41130.79434602808, 12902.161359511601, 12975.610731678065, 13083.08418410721, 13132.277724725232, 13147.802782958262, 9850.50747462624, 9901.257405694601, 9901.75245618851, 9902.851457228147, 9928.702138935843, 13586.456541738418, 13881.722365552834, 13888.375023123781, 13934.094283871718, 13992.720145597032, 5646.57650676201, 5656.264685590929, 5670.291213598301, 5740.799072032459, 5746.224259724883, 867.5878957495139, 870.8432482153273, 880.4145243413059, 887.0995939121797, 985.7338518599938, 29632.0, 31043.84478077595, 31097.53353699696, 31204.219894502367, 31883.202919926724, 973.2432365535562, 973.6640858903809, 997.6209040564539, 1011.6661501704419, 1074.5272080284649, 13751.381187846571, 13909.095908765898, 14136.15183089018, 14259.0, 14392.784108238386, 393057.0, 399724.0, 400932.0, 401839.0, 403259.0, 49445.752771235915, 49597.50402496001, 49605.0, 49858.0, 49875.75062124666, 1254.29759334771, 1254.6988722706667, 1256.9874301257237, 1259.8110283457372, 1345.488714288564, 25678.871605641853, 26727.0, 26895.058672946354, 26962.32594185161, 27098.593521097595, 41817.0, 41854.0, 42114.0, 42179.0, 42386.152276953675, 291493.0, 291686.0, 291789.0, 292629.0, 294716.0, 29793.0, 42281.57718422776, 43327.35008974931, 43697.78151109224, 43947.0, 37906.43140352952, 38477.0, 38537.421938671505, 38680.6131938677, 39178.2164356717, 28328.43343133167, 28967.565486518142, 35535.0, 39193.608063919, 39907.40138897861, 32511.512327314635, 32830.507542387364, 32876.342473149925, 33007.33985320328, 33121.668783311856, 27112.864435677697, 27156.72843271542, 27699.58450623202, 27704.58443123395, 27759.0, 25115.74884251134, 26137.869310653325, 26429.207123786317, 26561.203163905113, 27055.72944270532, 23490.412739681644, 23824.642630360904, 23956.40108997289, 24215.273541793773, 24329.75670243275], "unit": "score", "name": "ext.html", "value": 16991.95095268149}, {"lowerIsBetter": false, "replicates": [348.5277449056527, 350.58630815637537, 353.64988661225397, 356.4386091905249, 358.19942428671914, 16083.0, 17161.742573861404, 17478.825211747877, 18089.90955045223, 18694.15876285565, 15681.0, 15721.764173537405, 15856.207189640501, 15908.920455397707, 16236.350545978146, 5016.498350164981, 5122.103631864427, 5175.301334319875, 5204.037253108168, 5205.37535495741, 4436.889077773066, 5104.5405913467785, 5127.9743601282125, 5138.897222055557, 5145.0481660892665, 5442.727863606804, 5451.182322651614, 5460.563154947615, 5479.123340265558, 5488.643238189525, 5369.650972686783, 5402.675839449606, 5458.4814442627885, 5466.699331536764, 5487.725613719338, 4917.286993385975, 4943.134951383529, 4961.08219979305, 4968.130577149021, 4984.426790919055, 14000.0, 19573.902130489256, 19806.603867922706, 19833.702494462595, 20435.0, 1971.5662554238045, 2057.444489987695, 2094.8114669679803, 2106.220698341608, 2130.5206328575946, 9603.32776705631, 9825.656102036395, 9980.101790838859, 12103.092268079841, 12610.243385396905, 1788.937387191442, 1793.7399077133873, 1801.1534578748099, 1827.4974382044911, 1833.431636192771, 61496.69251653758, 62250.68874655598, 63401.74781523096, 63516.68241658808, 64464.35535644631, 9966.651167209113, 9990.750231244278, 10300.896991029993, 10353.844692329621, 10362.533685984148, 12631.810522842165, 13071.346432678329, 13074.346282685829, 13090.934545327213, 13626.523071692443, 5954.07711804671, 6060.303065147476, 6731.798046058626, 7394.112706475257, 7484.663190156456, 7028.332308430691, 7058.9294107059295, 7074.6816393262425, 7192.100987376578, 7207.351338379466, 4342.82628694855, 4386.035072284092, 4397.824087036547, 4413.713108647928, 4415.359772832985, 1857.619188066443, 1865.123392005755, 1870.9064546772606, 1892.9242830286635, 1896.1088288504382, 808.4219782855287, 869.426178722053, 875.2210532625968, 895.0378343280998, 895.5969813583913, 16696.582585435463, 16771.83228167727, 16793.412230572114, 16853.747193792104, 17130.657386852192, 863.1023735315327, 924.385283786288, 927.79124696944, 932.2821427500922, 948.4735971535725, 9614.51927403627, 9768.36505627132, 9771.657991970247, 9781.364211326383, 9808.313418060667, 492640.0, 495602.0, 501955.0, 530711.0, 535889.0, 76970.0, 79525.60237198892, 81455.59272203602, 81699.0, 81742.59128704437, 1121.955121795119, 1132.0547342968548, 1162.1690491298762, 1188.0495603517152, 1188.2929656854158, 15719.371225151323, 15983.280752366403, 16000.199990000687, 16013.279402426686, 16086.43697470583, 32077.67922320747, 34982.825085875425, 35828.82085589555, 36106.09734756652, 36471.0, 42454.0, 42809.0, 44119.55880441283, 47145.764271179796, 47694.0, 9605.759856003655, 9668.951655241679, 9691.370060946016, 9862.704118876445, 9944.45305508204, 16198.433054843024, 16573.91713041427, 16815.159242037604, 17034.914825425793, 17189.31242750326, 13844.653883652989, 14286.499972501328, 14372.353244103831, 14500.057496262709, 14582.635434113809, 14117.0, 14542.41830326775, 14892.478763243234, 14995.10029398196, 15122.168280744665, 13354.732905341645, 14284.57146285613, 14333.918207585419, 14424.495142669955, 14616.634584135481, 9151.542422878696, 9157.221636161, 9265.583048762686, 9394.67118650844, 9440.905590944003, 13743.793843092162, 13943.16341019542, 13944.16335019902, 13999.53004934508, 14311.57065288043], "unit": "score", "name": "jquery.html", "value": 8783.793113126436}, {"lowerIsBetter": false, "replicates": [1482.3625840888415, 1535.2016951185383, 1593.3148746039199, 1608.3003893306409, 1625.528596706955, 7028.61342626156, 7194.96402517988, 7269.345758881706, 7308.159561650412, 7450.776476705694, 7275.963620181905, 7329.853402931938, 7341.77974660761, 7416.7774966751085, 7417.147028091771, 2190.0582749417786, 2231.665250212473, 2239.2722365231284, 2245.382519807058, 2248.055816557042, 2219.4673278413147, 2246.4496198431407, 2255.612798129155, 2257.2889539794996, 2263.219189379661, 2128.467883029243, 2178.2267295110246, 2184.552166805809, 2188.5951099046647, 2211.8672879627193, 2176.5646870625937, 2210.8673479591275, 2225.0, 2244.7755224477587, 2252.718410198725, 2111.1133324003954, 2121.5650791587686, 2128.5636444528836, 2142.721446211998, 2144.1852096203497, 7288.4169266459085, 7379.741709040211, 7382.261773822628, 7383.48315617907, 7385.963070184668, 4393.648508119343, 4433.977830110861, 4459.420275364214, 4460.375547423363, 4464.843730469451, 2946.4107178564373, 2965.3624470738896, 2973.3458639099363, 2983.0752466735166, 3011.9247018824485, 973.1922504321396, 993.3692105512979, 995.5470261031213, 1007.8639383683255, 1076.3219171921717, 9516.904830951671, 9546.188573971222, 9572.856407153899, 9617.27870409722, 9691.51542422876, 3799.069228039148, 3829.195868867513, 3925.0776067624083, 3930.449737036817, 3972.860949866799, 7776.144624091346, 7806.92193078062, 7808.258215469521, 7818.179091195457, 7825.0, 4140.730852494638, 4155.667546596265, 4162.542120366757, 4170.416141740159, 4175.916481670411, 3810.3522401191863, 3837.7910958048124, 3856.382978723391, 3881.844726210976, 3888.1446081861945, 3236.6116066072223, 3245.496947973068, 3257.9185520361707, 3265.232670322472, 3283.244853683666, 1007.959681612742, 1042.6819819954987, 1048.4128887822844, 1049.0244073012173, 1053.7892421515728, 953.0231512699538, 957.3107362698846, 1002.674130907458, 1008.8234558952154, 1179.8761130081389, 6611.0, 6619.304972977864, 6647.933520664731, 6679.599224046573, 6714.429273511709, 1035.9119474844572, 1036.8444733290066, 1039.6880935719255, 1044.7074819050679, 1054.3041592548882, 5267.947320526822, 5280.762365693553, 5287.9735601321745, 5290.841274761763, 5295.258663787073, 8466.40735148546, 8497.957510212409, 8549.829003419896, 8617.78455538604, 8630.223279904712, 8522.57387130641, 8546.572671366406, 8562.357823163287, 8589.957050214834, 8610.655573777103, 6499.675016249169, 6614.7023383947835, 6625.701843417058, 6695.230048544382, 6766.526343156031, 6660.933390666031, 6680.665966701743, 6687.0, 6701.32986701326, 6705.497087718343, 7685.385169186564, 7785.844283114193, 7865.882011769942, 7880.211978802074, 7907.011623547057, 7884.960575197088, 8013.398995075276, 8039.879401809095, 8060.83878322442, 8084.393670474856, 5892.35184129754, 6514.4788416925585, 6541.6075035496115, 6545.509086818603, 6568.310327415744, 6783.796486105425, 6807.829804254933, 6825.453963682993, 6836.077129587442, 6855.862882742417, 6277.0, 6334.90497642545, 6365.809025729235, 6509.414152726277, 6523.054157147092, 6387.489000879826, 6393.6163830170335, 6416.582922110048, 6454.806355809334, 6488.578242414228, 6436.903446448214, 6505.0, 6509.544331896722, 6523.445507131947, 6575.901361479678, 5921.644701317935, 5967.671778052075, 5978.940210597838, 5994.850128746816, 6026.578139530191, 6042.5770196087615, 6067.666278354733, 6081.908771368345, 6098.26820781509, 6110.847228819315], "unit": "score", "name": "mootools.html", "value": 4174.401271975696}, {"lowerIsBetter": false, "replicates": [332.7038935347541, 334.0379706445437, 339.1690358621375, 342.7446552318522, 344.95170676105334, 6274.686265686714, 6298.464630506401, 6351.777687780928, 6387.329330420309, 6468.902966455507, 6318.715657795398, 6334.683265836713, 6336.0, 6344.460720838734, 6345.0, 4747.52524747526, 4777.784999675023, 4799.328094066834, 4810.494898035691, 4832.9275060874115, 4793.257045158006, 4798.208295631217, 4803.231482962727, 4820.517948205186, 4832.806687732504, 4685.83599574015, 4738.881527961811, 4744.383230180072, 4771.832985845496, 4779.80880764769, 4766.571008609207, 4773.80904763809, 4779.187538118528, 4783.689060211075, 4788.449328327235, 4124.587541245882, 4154.4183814265725, 4162.542120366757, 4166.687498437629, 4173.728707633994, 6013.428724271187, 6027.126066720301, 6037.094435834616, 6045.0, 6045.486133678643, 5477.972610136924, 5599.832005039855, 5605.0, 5614.073677843151, 5622.128570071604, 6705.195376554796, 6709.630970296632, 6732.057511948331, 6742.359475849787, 6746.93253067468, 4566.520515345907, 4570.862874113782, 4577.702449340783, 4598.517155698637, 4619.330197121399, 6741.224759152711, 6921.1002569666125, 6929.341712537301, 6943.062686537354, 7045.788626341269, 4591.081783643284, 4619.976900115478, 4649.279361698942, 4659.20793465105, 4660.743659098782, 4722.6221902247735, 4724.71651700899, 4734.952650473451, 4735.621150307967, 4738.31294462308, 5471.945280547223, 5479.205515200274, 5490.615656904059, 5507.256520369699, 5515.917261241085, 6571.178602674666, 6692.096566963398, 6725.865482690417, 6729.528932974645, 6760.830979225559, 1628.9266982985557, 1660.9916950415413, 1667.5247554446923, 1668.215938508899, 1672.6821903838231, 1082.6156714366286, 1084.7830433913248, 1105.3147048829617, 1123.2530367305812, 1127.7913585986455, 6089.786857460056, 6148.569600127948, 6188.226471691039, 6195.16365290689, 6215.564910456315, 6729.764458243938, 6733.3266673333255, 6766.18805743314, 6782.966085169642, 6793.0, 6071.605345652519, 6166.506679465632, 6199.597026193283, 6202.906956395657, 6203.689815509207, 3711.4989476420337, 3731.832067556912, 3735.850565977385, 3736.9439458408146, 3737.663610275034, 7065.505414620927, 7069.116360454943, 7104.040954471184, 7122.323379278961, 7143.464240182007, 6782.541753523016, 6993.685284162225, 7006.054182685272, 7010.859782804316, 7020.894686579705, 7037.859242815218, 7072.151341839012, 7090.0, 7094.219635840053, 7100.076989991268, 6819.181698196248, 6855.725770969305, 6856.760013399507, 6859.828504287433, 6872.209695885037, 6680.3987641112535, 6753.1220941277315, 6830.180378354629, 6834.726610935507, 6861.622610756456, 6999.860002800017, 7013.894791578233, 7102.0, 7108.715651373887, 7131.215566287808, 4655.953440465688, 4656.208444564364, 4656.720596764205, 4671.252599584051, 4705.458872229738, 6767.593944363354, 6841.760538381132, 6861.519693621598, 6872.0, 6955.339242771928, 6769.289224631343, 6788.626625535643, 6812.216595091628, 6830.180378354629, 6858.142732158481, 6772.8486157354355, 6791.320867913169, 6801.0, 6802.183737951477, 6802.217744959393, 6510.7721229756735, 6604.702788374439, 6606.966965165144, 6607.80176594703, 6654.168228971379, 6767.796966091025, 6807.217170025312, 6812.591244525344, 6817.0, 6822.556533825285, 6622.437092847162, 6641.302663220292, 6654.367835055662, 6670.699818508276, 6678.165229346332], "unit": "score", "name": "prototype.html", "value": 5008.497197870783}, {"lowerIsBetter": false, "replicates": [651.9413252807246, 674.8852695041844, 715.6529083394554, 774.643663914599, 778.256764789626, 13130.803037954427, 13313.334333283321, 13340.332983350841, 13374.933125334372, 13436.52972145975, 12111.0, 12263.202891812027, 12297.323647199422, 12308.323042232674, 12330.136890417674, 593.5874567175792, 604.1059232336145, 700.2087640965701, 707.4729326651639, 736.4991805572208, 712.0956385390551, 728.6538894025349, 728.7485817392991, 732.4177279063158, 734.3794493652881, 751.4026349052516, 759.3242014607005, 768.7194174126431, 771.6836097200149, 771.9768406947801, 752.9962350188241, 755.5126943121684, 762.8512440074188, 763.8854171874235, 766.5170942306312, 557.5511713070977, 561.8146011816132, 562.9014922388566, 563.3296377311028, 563.7857614106613, 12014.759704805942, 12159.93920030403, 12208.877911220863, 12227.877721222763, 12270.32513211773, 11289.943550282278, 11795.469203885847, 12061.33662648554, 12082.33547154906, 12158.939205303917, 10405.531751071145, 10408.115310198642, 10571.94714026425, 10663.413512256822, 10720.624778132727, 3622.2393297407575, 3634.1641422472717, 3656.287024030315, 3701.648343407372, 3722.3671975764187, 46756.53243467556, 46875.5312446878, 46888.531114688754, 47099.29351059737, 47302.763486182695, 9780.804383912424, 9987.800243995225, 10133.0, 10195.413748841596, 10405.895941040493, 16670.99948006247, 16788.6642267154, 16792.580185495215, 16863.0, 16867.831321686626, 6864.279250678607, 6890.8621827563165, 7124.216336203013, 7203.89194162088, 7657.310842024244, 4186.727862688916, 4254.936175957363, 4268.786560671954, 4279.186954478639, 4337.436133302651, 2727.7681397081074, 2730.071775596307, 2745.1490038088255, 2750.422411293651, 2754.5730411786203, 513.9229115632685, 525.5952916254463, 526.5603221310172, 527.209186220669, 527.4962410897583, 620.2030390947701, 652.8628987912497, 653.2683394597985, 654.4404534123256, 702.7891632510226, 9358.251339892928, 9434.528273586431, 9660.516974151264, 9736.172425343784, 9996.300258981946, 501.503511523589, 619.6189343553682, 630.2657404124144, 652.5138771615177, 652.8270008447765, 4127.690423218271, 4212.747235165839, 4241.893952651147, 4384.320430333303, 4451.910961780811, 50904.490955089976, 51700.74149629228, 52552.21171682428, 53138.0, 54968.0, 49018.26472602914, 50250.74874625603, 50387.49612503901, 50395.0, 50874.0, 43252.567474325486, 43511.78244108759, 44079.33880991788, 44805.10389792186, 45158.32262516065, 8861.867071994055, 8923.41997770143, 9113.179813816789, 9138.17756401927, 9252.676156334495, 32719.836400818796, 33094.510747016924, 33485.16287092842, 33857.83071084629, 34677.91932484059, 42159.36760948527, 42160.0, 42212.366814497196, 43149.352759709254, 43472.56527434685, 9815.165710914653, 10217.897821021694, 10628.946855265674, 10727.570897164025, 10740.785184296426, 12122.992362763645, 12141.332226727614, 12175.817362739388, 12260.877391225973, 12379.62861114168, 9667.9033209667, 9818.116369526777, 9921.25590580695, 10281.422522778701, 10742.462876856282, 11411.201215914807, 11486.655400338002, 11626.883731162918, 11701.531938722695, 11836.526538938346, 11293.0, 11399.20205585601, 11596.478158483058, 11644.76710465769, 11710.765784684088, 9021.909780902108, 9212.493312867857, 9282.489463079595, 9540.570674319533, 10017.54921028541, 9116.817663646823, 9463.952680236554, 9804.1666458349, 9835.803283934138, 9936.701898943043], "unit": "score", "name": "yui.html", "value": 6055.936307622897}], "name": "dromaeo_css", "value": 6801.654462185015}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 115.0, 114.0, 116.0, 124.0, 114.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 157.0, 164.0, 127.0, 156.0, 150.0, 140.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 162.0, 164.0, 163.0, 165.0, 174.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 75.0, 71.0, 73.0, 134.0, 73.0, 78.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 95.0, 94.0, 95.0, 135.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 98.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 65.0, 66.0, 64.0, 63.0, 64.0, 62.0, 59.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [93.0, 89.0, 85.0, 88.0, 87.0, 93.0, 87.0, 87.0, 96.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 125.0, 127.0, 116.0, 118.0, 128.0, 126.0, 136.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [143.0, 155.0, 155.0, 164.0, 155.0, 143.0, 159.0, 156.0, 158.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 70.0, 71.0, 70.0, 69.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1537.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.97600540723218], "unit": "score", "name": "Richards", "value": 208.91723599999995}, {"lowerIsBetter": false, "replicates": [187.6172607879925], "unit": "score", "name": "DeltaBlue", "value": 352.4089399999998}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1042.752867570386], "unit": "score", "name": "RayTrace", "value": 709.6494509999998}, {"lowerIsBetter": false, "replicates": [722.543352601156], "unit": "score", "name": "Earley", "value": 922.3847919999998}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [24926.829268292684], "unit": "score", "name": "RegExp", "value": 36.54636497064577}, {"lowerIsBetter": false, "replicates": [737.656595431098], "unit": "score", "name": "Splay", "value": 110.47281418581414}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20967.49256444524}]} 06:03:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20967.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1537.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6801.65"}}} 06:03:46 INFO - Return code: 0 06:03:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:03:46 INFO - # TBPL SUCCESS # 06:03:46 INFO - Running post-action listener: _resource_record_post_action 06:03:46 INFO - Running post-run listener: _resource_record_post_run 06:03:47 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 20480; Write bytes: 558977024; Read time: 16; Write time: 484456 06:03:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235212800; Read time: 0; Write time: 302088 06:03:47 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 20480; Write bytes: 323764224; Read time: 16; Write time: 182368 06:03:47 INFO - Running post-run listener: _upload_blobber_files 06:03:47 INFO - Blob upload gear active. 06:03:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:03:47 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:03:47 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:03:47 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:03:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:48 INFO - (blobuploader) - INFO - Done attempting. 06:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:49 INFO - (blobuploader) - INFO - Done attempting. 06:03:49 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:49 INFO - Return code: 0 06:03:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:03:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e50867af33f0c15adcbb1d597e259f0ac8611202343030fed5ec49717bf6892f9acb0f13639db96ce923d72549b1498d1a586bc7b084a48dd160aa8f95f643f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61419d15a3d56aed5e5679bc0e68780208d77e913830254341bdc89d1bd79c0cbfd11242fd09d5efd8f9b114bbb01ed268d12e3b546cfb6b0c049a2390625342"} 06:03:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:03:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:03:49 INFO - Contents: 06:03:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e50867af33f0c15adcbb1d597e259f0ac8611202343030fed5ec49717bf6892f9acb0f13639db96ce923d72549b1498d1a586bc7b084a48dd160aa8f95f643f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61419d15a3d56aed5e5679bc0e68780208d77e913830254341bdc89d1bd79c0cbfd11242fd09d5efd8f9b114bbb01ed268d12e3b546cfb6b0c049a2390625342"} 06:03:49 INFO - Copying logs to upload dir... 06:03:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.332117 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-24 06:03:48.797499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 06:03:48.801470) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e50867af33f0c15adcbb1d597e259f0ac8611202343030fed5ec49717bf6892f9acb0f13639db96ce923d72549b1498d1a586bc7b084a48dd160aa8f95f643f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61419d15a3d56aed5e5679bc0e68780208d77e913830254341bdc89d1bd79c0cbfd11242fd09d5efd8f9b114bbb01ed268d12e3b546cfb6b0c049a2390625342"} build_url:https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/lSSpl49ZQnKAVH3wvGvb7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e50867af33f0c15adcbb1d597e259f0ac8611202343030fed5ec49717bf6892f9acb0f13639db96ce923d72549b1498d1a586bc7b084a48dd160aa8f95f643f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61419d15a3d56aed5e5679bc0e68780208d77e913830254341bdc89d1bd79c0cbfd11242fd09d5efd8f9b114bbb01ed268d12e3b546cfb6b0c049a2390625342"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 06:03:48.826007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 06:03:48.826324) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450959429.128647-960138101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 06:03:48.911549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 06:03:48.912060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 06:03:48.912513) ========= ========= Total master_lag: 0.34 =========