builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1451566349.12 results: success (0) buildid: 20151231023007 builduid: ad04bfb1e7ac4ee7aba7d2452a7ac2e6 revision: 00e76b919aab697c92ea5131194968fd37ac8f69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.123340) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.124129) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.124487) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006346 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.155900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.156184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.189679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.190013) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.239698) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.240007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.240497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.240819) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 04:52:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2015-12-31 04:52:29 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.350417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.350959) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.406546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.407108) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 00e76b919aab697c92ea5131194968fd37ac8f69 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 00e76b919aab697c92ea5131194968fd37ac8f69 --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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 04:52:29,732 truncating revision to first 12 chars 2015-12-31 04:52:29,732 Setting DEBUG logging. 2015-12-31 04:52:29,732 attempt 1/10 2015-12-31 04:52:29,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/00e76b919aab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 04:52:30,019 unpacking tar archive at: b2g-inbound-00e76b919aab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.978130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.978483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.986463) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.986746) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 04:52:29.987164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 04:52:29.987485) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:30 INFO - MultiFileLogger online at 20151231 04:52:30 in /builds/slave/test-pgo 04:52:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:52:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:52:30 INFO - {'append_to_log': False, 04:52:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:52:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:52:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:52:30 INFO - 'branch': 'B2G-Inbound', 04:52:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:30 INFO - 'config_files': ('talos/linux_config.py',), 04:52:30 INFO - 'default_actions': ('clobber', 04:52:30 INFO - 'read-buildbot-config', 04:52:30 INFO - 'download-and-extract', 04:52:30 INFO - 'populate-webroot', 04:52:30 INFO - 'create-virtualenv', 04:52:30 INFO - 'install', 04:52:30 INFO - 'run-tests'), 04:52:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:30 INFO - 'download_minidump_stackwalk': True, 04:52:30 INFO - 'download_symbols': 'ondemand', 04:52:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:30 INFO - 'installer_path': 'installer.exe', 04:52:30 INFO - 'log_level': 'info', 04:52:30 INFO - 'log_name': 'talos', 04:52:30 INFO - 'log_to_console': True, 04:52:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:30 INFO - 'opt_config_files': (), 04:52:30 INFO - 'pip_index': False, 04:52:30 INFO - 'sps_profile': False, 04:52:30 INFO - 'sps_profile_interval': 0, 04:52:30 INFO - 'suite': 'dromaeojs', 04:52:30 INFO - 'system_bits': '32', 04:52:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:30 INFO - 'title': 'talos-linux64-ix-015', 04:52:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:30 INFO - 'use_talos_json': True, 04:52:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:52:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:30 INFO - 'work_dir': 'build'} 04:52:30 INFO - ##### 04:52:30 INFO - ##### Running clobber step. 04:52:30 INFO - ##### 04:52:30 INFO - Running pre-action listener: _resource_record_pre_action 04:52:30 INFO - Running main action method: clobber 04:52:30 INFO - rmtree: /builds/slave/test-pgo/build 04:52:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:52:30 INFO - Running post-action listener: _resource_record_post_action 04:52:30 INFO - ##### 04:52:30 INFO - ##### Running read-buildbot-config step. 04:52:30 INFO - ##### 04:52:30 INFO - Running pre-action listener: _resource_record_pre_action 04:52:30 INFO - Running main action method: read_buildbot_config 04:52:30 INFO - Using buildbot properties: 04:52:30 INFO - { 04:52:30 INFO - "project": "", 04:52:30 INFO - "product": "firefox", 04:52:30 INFO - "script_repo_revision": "production", 04:52:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:52:30 INFO - "repository": "", 04:52:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:52:30 INFO - "buildid": "20151231023007", 04:52:30 INFO - "pgo_build": "True", 04:52:30 INFO - "basedir": "/builds/slave/test-pgo", 04:52:30 INFO - "buildnumber": 170, 04:52:30 INFO - "slavename": "talos-linux64-ix-015", 04:52:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:52:30 INFO - "platform": "ubuntu64_hw", 04:52:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:52:30 INFO - "branch": "b2g-inbound", 04:52:30 INFO - "repo_path": "integration/b2g-inbound", 04:52:30 INFO - "revision": "00e76b919aab697c92ea5131194968fd37ac8f69", 04:52:30 INFO - "stage_platform": "linux64-pgo", 04:52:30 INFO - "builduid": "ad04bfb1e7ac4ee7aba7d2452a7ac2e6", 04:52:30 INFO - "slavebuilddir": "test" 04:52:30 INFO - } 04:52:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:52:30 INFO - Running post-action listener: _resource_record_post_action 04:52:30 INFO - ##### 04:52:30 INFO - ##### Running download-and-extract step. 04:52:30 INFO - ##### 04:52:30 INFO - Running pre-action listener: _resource_record_pre_action 04:52:30 INFO - Running main action method: download_and_extract 04:52:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 INFO - https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/test_packages.json 04:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/test_packages.json 04:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:52:31 INFO - Downloaded 1302 bytes. 04:52:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:52:31 INFO - Using the following test package requirements: 04:52:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'jsshell-linux-x86_64.zip'], 04:52:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:52:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:52:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:31 INFO - https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:33 INFO - Downloaded 23195186 bytes. 04:52:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:52:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:52:34 INFO - Return code: 0 04:52:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52: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')]} 04:52:34 INFO - https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:37 INFO - Downloaded 23195186 bytes. 04:52:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:52:38 INFO - Return code: 0 04:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:38 INFO - https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:52:39 INFO - Downloaded 11132285 bytes. 04:52:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:52:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:52:40 INFO - Return code: 0 04:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:40 INFO - https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:52:43 INFO - Downloaded 54947165 bytes. 04:52:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:43 INFO - mkdir: /builds/slave/test-pgo/properties 04:52:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:52:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:52:43 INFO - Contents: 04:52:43 INFO - build_url:https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:43 INFO - Running post-action listener: _resource_record_post_action 04:52:43 INFO - Running post-action listener: set_extra_try_arguments 04:52:43 INFO - ##### 04:52:43 INFO - ##### Running populate-webroot step. 04:52:43 INFO - ##### 04:52:43 INFO - Running pre-action listener: _resource_record_pre_action 04:52:43 INFO - Running main action method: populate_webroot 04:52:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:43 INFO - '--tppagecycles', 04:52:43 INFO - '7'], 04:52:43 INFO - 'tests': ['tsvgm']}}, 04:52:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:52:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'tests': ['damp', 'tps']}, 04:52:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['damp', 'tps']}, 04:52:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:52:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:43 INFO - 'other': {'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'other_l64': {'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'other_nol64': {'tests': ['a11yr', 04:52:43 INFO - 'ts_paint', 04:52:43 INFO - 'tpaint', 04:52:43 INFO - 'sessionrestore', 04:52:43 INFO - 'sessionrestore_no_auto_restore']}, 04:52:43 INFO - 'svgr': {'tests': ['tsvgx', 04:52:43 INFO - 'tsvgr_opacity', 04:52:43 INFO - 'tart', 04:52:43 INFO - 'tscrollx', 04:52:43 INFO - 'cart']}, 04:52:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['tsvgx', 04:52:43 INFO - 'tsvgr_opacity', 04:52:43 INFO - 'tart', 04:52:43 INFO - 'tscrollx', 04:52:43 INFO - 'cart']}, 04:52:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'tests': ['tp5o']}, 04:52:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'talos_options': ['--e10s'], 04:52:43 INFO - 'tests': ['tp5o']}, 04:52:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'talos_options': ['--xperf_path', 04:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:43 INFO - 'tests': ['tp5n']}, 04:52:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:43 INFO - 'talos_options': ['--e10s', 04:52:43 INFO - '--xperf_path', 04:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:43 INFO - 'tests': ['tp5n']}}, 04:52:43 INFO - 'talos.zip': {'path': '', 04:52:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:43 INFO - Running post-action listener: _resource_record_post_action 04:52:43 INFO - ##### 04:52:43 INFO - ##### Running create-virtualenv step. 04:52:43 INFO - ##### 04:52:43 INFO - Running pre-action listener: _resource_record_pre_action 04:52:43 INFO - Running main action method: create_virtualenv 04:52:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:52:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:52:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:52:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:43 INFO - Using real prefix '/usr' 04:52:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:52:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:45 INFO - Installing pip.................done. 04:52:45 INFO - Return code: 0 04:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:45 INFO - Using env: {'DISPLAY': ':0', 04:52:45 INFO - 'HOME': '/home/cltbld', 04:52:45 INFO - 'LANG': 'en_US.UTF-8', 04:52:45 INFO - 'LANGUAGE': 'en_US:en', 04:52:45 INFO - 'LOGNAME': 'cltbld', 04:52:45 INFO - 'MAIL': '/var/mail/cltbld', 04:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:45 INFO - 'MOZ_NO_REMOTE': '1', 04:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:45 INFO - 'NO_EM_RESTART': '1', 04:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:45 INFO - 'SHELL': '/bin/bash', 04:52:45 INFO - 'SHLVL': '1', 04:52:45 INFO - 'TERM': 'linux', 04:52:45 INFO - 'TMOUT': '86400', 04:52:45 INFO - 'USER': 'cltbld', 04:52:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:45 INFO - '_': '/tools/buildbot/bin/python'} 04:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:52:46 INFO - Cleaning up... 04:52:46 INFO - Return code: 0 04:52:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:52:46 INFO - Using env: {'DISPLAY': ':0', 04:52:46 INFO - 'HOME': '/home/cltbld', 04:52:46 INFO - 'LANG': 'en_US.UTF-8', 04:52:46 INFO - 'LANGUAGE': 'en_US:en', 04:52:46 INFO - 'LOGNAME': 'cltbld', 04:52:46 INFO - 'MAIL': '/var/mail/cltbld', 04:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:46 INFO - 'MOZ_NO_REMOTE': '1', 04:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:46 INFO - 'NO_EM_RESTART': '1', 04:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:46 INFO - 'SHELL': '/bin/bash', 04:52:46 INFO - 'SHLVL': '1', 04:52:46 INFO - 'TERM': 'linux', 04:52:46 INFO - 'TMOUT': '86400', 04:52:46 INFO - 'USER': 'cltbld', 04:52:46 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:46 INFO - '_': '/tools/buildbot/bin/python'} 04:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:46 INFO - Downloading/unpacking psutil>=0.7.1 04:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:52:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:52:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:48 INFO - Installing collected packages: psutil 04:52:48 INFO - Running setup.py install for psutil 04:52:48 INFO - building 'psutil._psutil_linux' extension 04:52:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:52:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:52:48 INFO - building 'psutil._psutil_posix' extension 04:52:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:52:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:48 INFO - Successfully installed psutil 04:52:48 INFO - Cleaning up... 04:52:48 INFO - Return code: 0 04:52:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:52:48 INFO - Using env: {'DISPLAY': ':0', 04:52:48 INFO - 'HOME': '/home/cltbld', 04:52:48 INFO - 'LANG': 'en_US.UTF-8', 04:52:48 INFO - 'LANGUAGE': 'en_US:en', 04:52:48 INFO - 'LOGNAME': 'cltbld', 04:52:48 INFO - 'MAIL': '/var/mail/cltbld', 04:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:48 INFO - 'MOZ_NO_REMOTE': '1', 04:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:48 INFO - 'NO_EM_RESTART': '1', 04:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:48 INFO - 'SHELL': '/bin/bash', 04:52:48 INFO - 'SHLVL': '1', 04:52:48 INFO - 'TERM': 'linux', 04:52:48 INFO - 'TMOUT': '86400', 04:52:48 INFO - 'USER': 'cltbld', 04:52:48 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:48 INFO - '_': '/tools/buildbot/bin/python'} 04:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:50 INFO - Installing collected packages: mozsystemmonitor 04:52:50 INFO - Running setup.py install for mozsystemmonitor 04:52:50 INFO - Successfully installed mozsystemmonitor 04:52:50 INFO - Cleaning up... 04:52:50 INFO - Return code: 0 04:52:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:50 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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:50 INFO - Using env: {'DISPLAY': ':0', 04:52:50 INFO - 'HOME': '/home/cltbld', 04:52:50 INFO - 'LANG': 'en_US.UTF-8', 04:52:50 INFO - 'LANGUAGE': 'en_US:en', 04:52:50 INFO - 'LOGNAME': 'cltbld', 04:52:50 INFO - 'MAIL': '/var/mail/cltbld', 04:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:50 INFO - 'MOZ_NO_REMOTE': '1', 04:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:50 INFO - 'NO_EM_RESTART': '1', 04:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:50 INFO - 'SHELL': '/bin/bash', 04:52:50 INFO - 'SHLVL': '1', 04:52:50 INFO - 'TERM': 'linux', 04:52:50 INFO - 'TMOUT': '86400', 04:52:50 INFO - 'USER': 'cltbld', 04:52:50 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:50 INFO - '_': '/tools/buildbot/bin/python'} 04:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:52:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:53 INFO - Downloading docopt-0.6.1.tar.gz 04:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:53 INFO - Running setup.py install for blobuploader 04:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:52:53 INFO - Running setup.py install for requests 04:52:53 INFO - Running setup.py install for docopt 04:52:53 INFO - Successfully installed blobuploader requests docopt 04:52:53 INFO - Cleaning up... 04:52:54 INFO - Return code: 0 04:52:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:52: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')]} 04:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:54 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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:54 INFO - Using env: {'DISPLAY': ':0', 04:52:54 INFO - 'HOME': '/home/cltbld', 04:52:54 INFO - 'LANG': 'en_US.UTF-8', 04:52:54 INFO - 'LANGUAGE': 'en_US:en', 04:52:54 INFO - 'LOGNAME': 'cltbld', 04:52:54 INFO - 'MAIL': '/var/mail/cltbld', 04:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:54 INFO - 'MOZ_NO_REMOTE': '1', 04:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:54 INFO - 'NO_EM_RESTART': '1', 04:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:54 INFO - 'SHELL': '/bin/bash', 04:52:54 INFO - 'SHLVL': '1', 04:52:54 INFO - 'TERM': 'linux', 04:52:54 INFO - 'TMOUT': '86400', 04:52:54 INFO - 'USER': 'cltbld', 04:52:54 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:54 INFO - '_': '/tools/buildbot/bin/python'} 04:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:54 INFO - Running setup.py (path:/tmp/pip-UFgdVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:54 INFO - Running setup.py (path:/tmp/pip-MtZ7q8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:54 INFO - Running setup.py (path:/tmp/pip-seF056-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:54 INFO - Running setup.py (path:/tmp/pip-wDRfLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:54 INFO - Running setup.py (path:/tmp/pip-n1n81B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:54 INFO - Running setup.py (path:/tmp/pip-h21Px7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:54 INFO - Running setup.py (path:/tmp/pip-MEW1G3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:54 INFO - Running setup.py (path:/tmp/pip-7P10jz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:54 INFO - Running setup.py (path:/tmp/pip-J4KxYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:54 INFO - Running setup.py (path:/tmp/pip-rBbJRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:54 INFO - Running setup.py (path:/tmp/pip-2mffuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:55 INFO - Running setup.py (path:/tmp/pip-PLwR0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:55 INFO - Running setup.py (path:/tmp/pip-LdVSJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:55 INFO - Running setup.py (path:/tmp/pip-BozAi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Running setup.py (path:/tmp/pip-vMQogl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:55 INFO - Running setup.py (path:/tmp/pip-DO1xMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:55 INFO - Running setup.py (path:/tmp/pip-kYbgzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:55 INFO - Running setup.py install for manifestparser 04:52:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:52:55 INFO - Running setup.py install for mozcrash 04:52:55 INFO - Running setup.py install for mozdebug 04:52:55 INFO - Running setup.py install for mozdevice 04:52:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:52:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:52:55 INFO - Running setup.py install for mozfile 04:52:55 INFO - Running setup.py install for mozhttpd 04:52:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozinfo 04:52:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozInstall 04:52:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozleak 04:52:56 INFO - Running setup.py install for mozlog 04:52:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for moznetwork 04:52:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozprocess 04:52:56 INFO - Running setup.py install for mozprofile 04:52:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozrunner 04:52:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:52:56 INFO - Running setup.py install for mozscreenshot 04:52:57 INFO - Running setup.py install for moztest 04:52:57 INFO - Running setup.py install for mozversion 04:52:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:52:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:57 INFO - Cleaning up... 04:52:57 INFO - Return code: 0 04:52:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:57 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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:57 INFO - Using env: {'DISPLAY': ':0', 04:52:57 INFO - 'HOME': '/home/cltbld', 04:52:57 INFO - 'LANG': 'en_US.UTF-8', 04:52:57 INFO - 'LANGUAGE': 'en_US:en', 04:52:57 INFO - 'LOGNAME': 'cltbld', 04:52:57 INFO - 'MAIL': '/var/mail/cltbld', 04:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:57 INFO - 'MOZ_NO_REMOTE': '1', 04:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:57 INFO - 'NO_EM_RESTART': '1', 04:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:57 INFO - 'SHELL': '/bin/bash', 04:52:57 INFO - 'SHLVL': '1', 04:52:57 INFO - 'TERM': 'linux', 04:52:57 INFO - 'TMOUT': '86400', 04:52:57 INFO - 'USER': 'cltbld', 04:52:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:57 INFO - '_': '/tools/buildbot/bin/python'} 04:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:57 INFO - Running setup.py (path:/tmp/pip-_vOxXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:57 INFO - Running setup.py (path:/tmp/pip-xAzPeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:57 INFO - Running setup.py (path:/tmp/pip-an7vkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:57 INFO - Running setup.py (path:/tmp/pip-s9rO1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:57 INFO - Running setup.py (path:/tmp/pip-uVcoRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:57 INFO - Running setup.py (path:/tmp/pip-ue37wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:57 INFO - Running setup.py (path:/tmp/pip-L84NoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:57 INFO - Running setup.py (path:/tmp/pip-ax5q0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:58 INFO - Running setup.py (path:/tmp/pip-QOoU_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:58 INFO - Running setup.py (path:/tmp/pip-CVAoak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:58 INFO - Running setup.py (path:/tmp/pip-P26VIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:58 INFO - Running setup.py (path:/tmp/pip-xKRSoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:58 INFO - Running setup.py (path:/tmp/pip-63JIFY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:58 INFO - Running setup.py (path:/tmp/pip-cQ1EBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:58 INFO - Running setup.py (path:/tmp/pip-iTC35A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:58 INFO - Running setup.py (path:/tmp/pip-rUtcdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:58 INFO - Running setup.py (path:/tmp/pip-8BBxYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:53:00 INFO - Downloading blessings-1.5.1.tar.gz 04:53:00 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:00 INFO - Installing collected packages: blessings 04:53:00 INFO - Running setup.py install for blessings 04:53:00 INFO - Successfully installed blessings 04:53:00 INFO - Cleaning up... 04:53:00 INFO - Return code: 0 04:53:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:53:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:53:00 INFO - Reading from file tmpfile_stdout 04:53:00 INFO - Current package versions: 04:53:00 INFO - argparse == 1.2.1 04:53:00 INFO - blessings == 1.5.1 04:53:00 INFO - blobuploader == 1.2.4 04:53:00 INFO - docopt == 0.6.1 04:53:00 INFO - manifestparser == 1.1 04:53:00 INFO - mozInstall == 1.12 04:53:00 INFO - mozcrash == 0.16 04:53:00 INFO - mozdebug == 0.1 04:53:00 INFO - mozdevice == 0.47 04:53:00 INFO - mozfile == 1.2 04:53:00 INFO - mozhttpd == 0.7 04:53:00 INFO - mozinfo == 0.9 04:53:00 INFO - mozleak == 0.1 04:53:00 INFO - mozlog == 3.1 04:53:00 INFO - moznetwork == 0.27 04:53:00 INFO - mozprocess == 0.22 04:53:00 INFO - mozprofile == 0.28 04:53:00 INFO - mozrunner == 6.11 04:53:00 INFO - mozscreenshot == 0.1 04:53:00 INFO - mozsystemmonitor == 0.0 04:53:00 INFO - moztest == 0.7 04:53:00 INFO - mozversion == 1.4 04:53:00 INFO - psutil == 3.1.1 04:53:00 INFO - requests == 1.2.3 04:53:00 INFO - wsgiref == 0.1.2 04:53:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '-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 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:53:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:00 INFO - Using env: {'DISPLAY': ':0', 04:53:00 INFO - 'HOME': '/home/cltbld', 04:53:00 INFO - 'LANG': 'en_US.UTF-8', 04:53:00 INFO - 'LANGUAGE': 'en_US:en', 04:53:00 INFO - 'LOGNAME': 'cltbld', 04:53:00 INFO - 'MAIL': '/var/mail/cltbld', 04:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:00 INFO - 'MOZ_NO_REMOTE': '1', 04:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:00 INFO - 'NO_EM_RESTART': '1', 04:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:00 INFO - 'SHELL': '/bin/bash', 04:53:00 INFO - 'SHLVL': '1', 04:53:00 INFO - 'TERM': 'linux', 04:53:00 INFO - 'TMOUT': '86400', 04:53:00 INFO - 'USER': 'cltbld', 04:53:00 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:00 INFO - '_': '/tools/buildbot/bin/python'} 04:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:53:01 INFO - Cleaning up... 04:53:01 INFO - Return code: 0 04:53:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:01 INFO - Using env: {'DISPLAY': ':0', 04:53:01 INFO - 'HOME': '/home/cltbld', 04:53:01 INFO - 'LANG': 'en_US.UTF-8', 04:53:01 INFO - 'LANGUAGE': 'en_US:en', 04:53:01 INFO - 'LOGNAME': 'cltbld', 04:53:01 INFO - 'MAIL': '/var/mail/cltbld', 04:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:01 INFO - 'MOZ_NO_REMOTE': '1', 04:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:01 INFO - 'NO_EM_RESTART': '1', 04:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:01 INFO - 'SHELL': '/bin/bash', 04:53:01 INFO - 'SHLVL': '1', 04:53:01 INFO - 'TERM': 'linux', 04:53:01 INFO - 'TMOUT': '86400', 04:53:01 INFO - 'USER': 'cltbld', 04:53:01 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:01 INFO - '_': '/tools/buildbot/bin/python'} 04:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:01 INFO - Downloading/unpacking jsonschema 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:53:02 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:53:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:03 INFO - warning: no files found matching '*.txt' 04:53:03 INFO - no previously-included directories found matching 'build' 04:53:03 INFO - no previously-included directories found matching 'dist' 04:53:03 INFO - no previously-included directories found matching '.git*' 04:53:03 INFO - Installing collected packages: jsonschema, functools32 04:53:03 INFO - Running setup.py install for functools32 04:53:03 INFO - warning: no files found matching '*.txt' 04:53:03 INFO - no previously-included directories found matching 'build' 04:53:03 INFO - no previously-included directories found matching 'dist' 04:53:03 INFO - no previously-included directories found matching '.git*' 04:53:03 INFO - Successfully installed jsonschema functools32 04:53:03 INFO - Cleaning up... 04:53:03 INFO - Return code: 0 04:53:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:53: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')]} 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aceb4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, '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': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53: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', 'flake8'] in /builds/slave/test-pgo/build 04:53: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 flake8 04:53:03 INFO - Using env: {'DISPLAY': ':0', 04:53:03 INFO - 'HOME': '/home/cltbld', 04:53:03 INFO - 'LANG': 'en_US.UTF-8', 04:53:03 INFO - 'LANGUAGE': 'en_US:en', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MAIL': '/var/mail/cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SHLVL': '1', 04:53:03 INFO - 'TERM': 'linux', 04:53:03 INFO - 'TMOUT': '86400', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - '_': '/tools/buildbot/bin/python'} 04:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:03 INFO - Downloading/unpacking flake8 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:53:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:53:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:53:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:05 INFO - no previously-included directories found matching 'docs/_build' 04:53:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:06 INFO - Running setup.py install for pep8 04:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:06 INFO - no previously-included directories found matching 'docs/_build' 04:53:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:53:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:06 INFO - Cleaning up... 04:53:06 INFO - Return code: 0 04:53:06 INFO - Running post-action listener: _resource_record_post_action 04:53:06 INFO - Running post-action listener: _start_resource_monitoring 04:53:06 INFO - Starting resource monitoring. 04:53:06 INFO - ##### 04:53:06 INFO - ##### Running install step. 04:53:06 INFO - ##### 04:53:06 INFO - Running pre-action listener: _resource_record_pre_action 04:53:06 INFO - Running main action method: install 04:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:53:06 INFO - Reading from file tmpfile_stdout 04:53:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:53:06 INFO - Reading from file tmpfile_stdout 04:53:06 INFO - Output received: 04:53:06 INFO - Usage: mozinstall [options] installer 04:53:06 INFO - Options: 04:53:06 INFO - -h, --help show this help message and exit 04:53:06 INFO - -d DEST, --destination=DEST 04:53:06 INFO - Directory to install application into. [default: 04:53:06 INFO - "/builds/slave/test-pgo"] 04:53:06 INFO - --app=APP Application being installed. [default: firefox] 04:53:06 INFO - mkdir: /builds/slave/test-pgo/build/application 04:53:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:53:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:53:22 INFO - Reading from file tmpfile_stdout 04:53:22 INFO - Output received: 04:53:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:53:22 INFO - Running post-action listener: _resource_record_post_action 04:53:22 INFO - ##### 04:53:22 INFO - ##### Running run-tests step. 04:53:22 INFO - ##### 04:53:22 INFO - Running pre-action listener: _resource_record_pre_action 04:53:22 INFO - Running main action method: run_tests 04:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:53:22 INFO - Python 2.7.3 04:53:22 INFO - Return code: 0 04:53:22 INFO - grabbing minidump binary from tooltool 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:22 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 0x17b8660>, '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 0x17b9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:53:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:53:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:53:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:22 INFO - Return code: 0 04:53:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:53:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:53:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:53:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:53:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:53:23 INFO - Return code: 0 04:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:53:23 INFO - Using env: {'DISPLAY': ':0', 04:53:23 INFO - 'HOME': '/home/cltbld', 04:53:23 INFO - 'LANG': 'en_US.UTF-8', 04:53:23 INFO - 'LANGUAGE': 'en_US:en', 04:53:23 INFO - 'LOGNAME': 'cltbld', 04:53:23 INFO - 'MAIL': '/var/mail/cltbld', 04:53:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:53:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:23 INFO - 'MOZ_NO_REMOTE': '1', 04:53:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:23 INFO - 'NO_EM_RESTART': '1', 04:53:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:53:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:53:23 INFO - 'SHELL': '/bin/bash', 04:53:23 INFO - 'SHLVL': '1', 04:53:23 INFO - 'TERM': 'linux', 04:53:23 INFO - 'TMOUT': '86400', 04:53:23 INFO - 'USER': 'cltbld', 04:53:23 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944', 04:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:23 INFO - '_': '/tools/buildbot/bin/python'} 04:53:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:23 INFO - mozversion application_buildid: 20151231023007 04:53:23 INFO - mozversion application_changeset: 00e76b919aab697c92ea5131194968fd37ac8f69 04:53:23 INFO - mozversion application_display_name: Nightly 04:53:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:23 INFO - mozversion application_name: Firefox 04:53:23 INFO - mozversion application_remotingname: firefox 04:53:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:53:23 INFO - mozversion application_vendor: Mozilla 04:53:23 INFO - mozversion application_version: 46.0a1 04:53:23 INFO - mozversion platform_buildid: 20151231023007 04:53:23 INFO - mozversion platform_changeset: 00e76b919aab697c92ea5131194968fd37ac8f69 04:53:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:53:23 INFO - mozversion platform_version: 46.0a1 04:53:23 INFO - using testdate: 1451566403 04:53:23 INFO - actual date: 1451566403 04:53:23 INFO - starting webserver on 'localhost:37881' 04:53:23 INFO - SUITE-START | Running 3 tests 04:53:23 INFO - TEST-START | dromaeo_css 04:53:23 INFO - operating with platform_type : linux_ 04:53:23 INFO - Initialising browser for dromaeo_css test... 04:53:23 INFO - TEST-INFO | started process 12335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfbmyWW/profile http://localhost:37881/getInfo.html) 04:53:27 INFO - PROCESS | 12335 | __metrics Screen width/height:1600/1200 04:53:27 INFO - PROCESS | 12335 | colorDepth:24 04:53:27 INFO - PROCESS | 12335 | Browser inner width/height: 1024/697 04:53:27 INFO - PROCESS | 12335 | __metrics 04:53:28 INFO - PROCESS | 12335 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:53:28 INFO - PROCESS | 12335 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:29 INFO - TEST-INFO | 12335: exit 0 04:53:29 INFO - Browser initialized. 04:53:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:29 INFO - TEST-INFO | started process 12428 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfbmyWW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:41 INFO - PROCESS | 12428 | RSS: Main: 149602304 04:53:41 INFO - PROCESS | 12428 | 04:54:32 INFO - PROCESS | 12428 | 1451566472677 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] 04:56:41 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37881/tests/dromaeo/cssquery-ext.html) 04:56:42 INFO - PROCESS | 12428 | RSS: Main: 259072000 04:56:42 INFO - PROCESS | 12428 | 04:59:45 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-ext.html (next: http://localhost:37881/tests/dromaeo/cssquery-jquery.html) 04:59:45 INFO - PROCESS | 12428 | RSS: Main: 237162496 04:59:45 INFO - PROCESS | 12428 | 05:02:47 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37881/tests/dromaeo/cssquery-mootools.html) 05:02:48 INFO - PROCESS | 12428 | RSS: Main: 230363136 05:02:48 INFO - PROCESS | 12428 | 05:05:50 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37881/tests/dromaeo/cssquery-prototype.html) 05:05:50 INFO - PROCESS | 12428 | RSS: Main: 211701760 05:05:50 INFO - PROCESS | 12428 | 05:08:53 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37881/tests/dromaeo/cssquery-yui.html) 05:08:53 INFO - PROCESS | 12428 | RSS: Main: 196034560 05:08:53 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | Cycle 1(1): loaded http://localhost:37881/tests/dromaeo/cssquery-yui.html (next: http://localhost:37881/tests/dromaeo/cssquery-dojo.html) 05:11:56 INFO - PROCESS | 12428 | RSS: Main: 298463232 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | __start_tp_report 05:11:56 INFO - PROCESS | 12428 | _x_x_mozilla_page_load 05:11:56 INFO - PROCESS | 12428 | _x_x_mozilla_page_load_details 05:11:56 INFO - PROCESS | 12428 | |i|pagename|runs| 05:11:56 INFO - PROCESS | 12428 | |0;dojo.html;3103.441380551501;3168.6989735975103;3217.388696147732;3218.533312669663;3242.724368428684;5152.845414637558;5263.552598029172;5289.973550132248;5329.626926115174;5397.136458166694;5177.5599074078655;5298.09932311507;5332.92000619991;5363.061464243761;5396.622236443451;4827.3000414939725;4833.468318484964;4834.613230941516;4861.829835955742;4925.507449255064;4822.517748225185;4891.095147397743;4940.110780059588;4943.6539442239055;4986.650934434591;4728.40894888139;4742.478327383985;4826.444958829709;4877.487863774306;4877.561019508261;4873.658843880929;4878.219484882402;4881.292212629149;4890.8043678252825;4931.926021109686;4836.637252206064;4849.733264670442;4862.805487780484;4864.586510146642;4906.803727850882;5067.290579318898;5129.25625784263;5149.510796474329;5202.635815492917;5236.607254455931;5739.454751798572;5752.8849423011725;5755.712214389264;5759.942400575983;5775.306963164448;5758.165066065439;5777.393373695743;5777.682227477487;5781.595288329819;5782.277215348082;5254.789808407697;5318.069337865858;5346.91979620306;5359.249705041337;5378.623496355257;5803.9419605803405;5804.622699524517;5807.651540907559;5809.796657116981;5849.736761845727;5541.972290138604;5548.112302031655;5549.778008879681;5576.722040834568;5594.636348637326;5593.664380137205;5628.437156284421;5629.211910332557;5675.858103547444;5700.714964251771;5621.297337832771;5662.971685141548;5670.461306175989;5672.404397538282;5704;5667.8866422672145;5671.120976248606;5672.035753921843;5672.97163514188;5680.289963754531;4269.957300426956;4358.629516491071;4436.157130145262;4452.933206001912;4458.152950939311;3938.724289299779;3941.2117576484816;3941.6058394160927;3977.9204415911518;3984.5218573770753;5295.682259064469;5297.65565238266;5301.204819277139;5304.098303288451;5310;5637.943620563742;5719.170720245541;5743.885122297531;5750.424957504216;5834;5273.077211487975;5276.604254680914;5277.340332458442;5292.20616907467;5323.041852466593;4950.950490495121;4956.405231372259;4961.4294356148785;4966.975165124151;5004.874878128076;5744.971275143597;5821.76712931478;5831.708414579254;5844;5875.3243377012195;5703.714814259188;5794.942050579609;5800.419958004166;5803.564732644984;5852.853678658068;5840.766369345179;5844.620099693507;5848.853778655397;5854.590178687451;5858.297004359334;5487.039768040497;5582.637128586629;5585.357683866245;5648.915266271091;5653.152027195953;5566;5640.689762063126;5658.9151162733415;5758.539316854558;5776.220210271727;5625.240592520121;5629.043062679272;5631.436856314336;5631.746571404215;5637.041702910433;5534.612577119724;5616.578756593353;5621.831345059655;5622.2128901954575;5624.465675760796;5373.11343628297;5405.78376864921;5493.560515158858;5510.035743744908;5539.944600553943;5654.378018418053;5658.377578466448;5677.148427735872;5684.062129748545;5748.109043098327;5359.383670877899;5516.668999860021;5529.115341545495;5562.944370556243;5572.331320241597 05:11:56 INFO - PROCESS | 12428 | |1;ext.html;548.7942021741846;551.0494397164891;567.135118943611;576.9672286606974;604.4137186928681;28142;28589.142325730234;38663.22673546527;39511.802440987754;39557.208855822864;42630;43023.35464968028;43051.138977220435;43072.78463607677;43168.352474712905;7359.521631093989;8666.610002549869;8828.117188281152;8830.602622881954;8842.513661748633;7432;10110.191184705243;10272.33229840058;10335.534900929439;10350.637727679532;10035.648752293635;10055.597776088984;10162.08541231289;10168.44073575953;10173.491325433699;7543.321101100927;7706.306432421109;10035.096841284283;10084.14284785794;10165.085142337151;9915.206783457379;9926.255530835217;10043.296969212159;10079.44563049032;10083.394996300245;36397.27205455903;36823.815880920694;36826.07934801625;36839;36906.63093369059;3288.8684452621865;3309.271960168759;3379.8141102239365;3730.1607138393915;3876.2247550489733;28621.57067643987;28642.856785716147;28694.856525717445;28744.856275718488;29806;3901.3757798752063;3950.644442000234;3960.722749407543;3968.226195891802;4028.174224284044;259011;259398;259569;260215.9999999981;260374;50299.74850125799;51843.740781296605;57577.424225757204;58767.706161468916;59162.40837591569;53456.73271633695;53807.46192538103;54199.18701219406;54214.457855420944;54231;15247.695046099016;15428.922855385652;15480.458183963507;15547.222638868237;15551.611209719847;12073.758524829454;12092.939535302266;12140.635780926586;12148.757024859453;12183.02535797134;19264.422067338;19381.61236775285;19390.8060919389;19417.708734368996;19538.413847584594;7745.204849623757;7915.881261781078;7961.328121094635;8038.397120216007;8067.919320806717;987.170776547689;991.7520619845038;1038.231708535678;1051.726551096705;1085.375908852413;27425.31436714098;28179.577306340423;28511.71488285132;28785.71214287872;28955.276118097216;1005.894381089975;1024.7284469615558;1056;1057.9947100264449;1108.0692218536467;13296.601101966957;13318.600441986757;13558;13572.117812342167;13890.861091389159;321899;328153;329100;330193;330834;50607.74696126496;50863.23705144426;50903.49096509062;50908.99999999926;50968.74515627472;1352.9323533823467;1353.810466534686;1370.8012338210904;1372.5196181336453;1383.4535358533524;25021.74978250194;25781.87109064443;26507.469850602494;26568.468630627667;26738.59892101659;41236.175276494905;41503.58496414997;41619.7919010403;41719.37420938749;41766.79116604398;208112;208766;209330;209722;210253;27158.72841271641;27628.861855690593;28278.85860570684;30968;31518;36191;36902.26195476129;36906.8154659225;37038.814805925795;37795;33137;33352.83323583366;34365.65634343625;34828.303433930676;34829;30182;33416.09058698165;33537.49693754547;34331.485027724106;34393.82803085969;32953;33740.49389259212;33832.49251261282;33933.66066339404;34227.657723422446;28869.855650722453;29716.405671886874;30969.70029805455;31197.908073217328;31456;23668.763312367344;23676.289711308687;23734.978889250033;23832.642510362013;24011.879940600884 05:11:56 INFO - PROCESS | 12428 | |2;jquery.html;332.1745462525625;339.7078512479269;340.3839051317115;341.4724251032155;345.5456075261032;14540.345684444199;15005.549833504985;16226.432074877383;16271.186440677962;16972.321107155698;16284.185790710446;16521.586960325996;16563.751543726823;16594.17029148544;16779.161041947886;5195.168772996321;5291.074062039147;5328.360596728398;5329.147336426173;5338.332708411449;3975.8210880510446;4123.628873401393;5365.731713414333;5692.544596432296;5921.319048309457;5802.216700745409;5839.240898683165;5840;5858.414158584129;5858.619189752674;5664;5755.3381361143165;5805.7387417566315;5807.535397168238;5824.184614154022;5072.518110779507;5073.670211436245;5086.338775959139;5089.287499750001;5091.083604951107;20319.79680203194;20696.275630353015;20736.48158796042;20904.5819083619;20937.685934710993;2247.9213227536957;2248.190651365507;2323.6282194848914;2340.239422187779;2783.983845896233;12874.549390771372;12941.741165176643;12990.805137922938;13391.464341426428;13428.261445620486;1747.770395642548;1761.5772214668516;1786.8213178682029;1828.789689185734;1847.4043968224667;56586.43413565853;58808.11787823186;59035.40964590342;59324.703376483274;59351.40648593502;9046;9172.587233574504;9292.62829486813;9441.575129119068;9491.52881303399;12193.39033048344;12232.755344893052;12234.81647775284;12240;12248.44881980313;7374.33630973215;7401.407887368998;7539.0576177977755;7544.283293087148;7600.467967242351;7203.459740519482;7268.345848873627;7276.63616819157;7339.633018349061;7347.88978165328;5772.913406298909;5821.7380217890295;5827.271591051119;5831.329397119385;5871.236739223959;1487.2192099147817;1568.647054412748;1585.7542080977466;1654.9172541372884;1655.9337626494805;922.3866129024124;1006.4011912911806;1014.4724743133529;1077.175960390302;1116.9944150279196;11148.832767508495;11282.492287847066;11313.773724525463;11584.131190160771;11753.118516111326;430.90950900310656;449.6223172535021;450.31776858059413;458.47046661106475;474.34066647360197;9322.394044387092;9775.217982561378;10241.334313269614;10441.321314114559;10468.162546996375;569990;571014;575677;580417;583308;38883.416748748794;39338.01654958592;47159.29261061087;75305.24694752983;84107.5794621023;442.97120687155234;450.4347044459248;451.3117495818837;471.14722352541327;485.22121994199506;10553.947230263799;10704.250702451065;10729.785404292026;10733.892661073289;10905.018548330689;35435.468467973515;36083.45874811932;36379.45430818487;36395.09012274714;36640.267194655426;47455.52544474511;48055.519444805104;48103.27845082257;48614;51127.2330915044;9315.534223288943;9768;9773.951130244302;9794.461304628314;9802.313838031268;11303.378314192469;11410.885891140982;12178.939105304416;15619.453319133776;17410.738838917172;13934.651633709238;14179.14925104497;14315.928420357832;14436.566902992927;14481.131132132106;13857.584272471842;14224.217668027944;14441.638959026108;14557.781633275297;14967.40130394772;10462.738431539272;11812;14186.432542698176;14631.341589628706;15248.3900643973;9425.622975081194;9568.904310956801;9682.080202380763;9692.273079518924;9780.315377923476;10240.078392944672;12729.936350318188;13842.4463021478;14002.509912153026;14674.853251467348 05:11:56 INFO - PROCESS | 12428 | |3;mootools.html;1278.316100886026;1410.696700209455;1418.7020725647612;1542.8842836787237;1733.5579427246043;6392.584482008666;7057.717691292349;7151.856962860739;7154.678039488216;7227.530210536312;7035.824104397393;7178.318059784325;7205.243449437812;7224.891626625605;7232.710691572331;1909.102721720789;1949.337225343383;2162.7996461963644;2174.423777698911;2177.085624037908;2148.8280937525037;2150.290404166621;2153.5369895472472;2156.008236211345;2157.8273738100993;2126.9042893069773;2252.481929156295;2253.5380247049397;2255.1994042114975;2257.0294773247497;2114.302280247515;2119.4171602809197;2146.957060858782;2156.0728886578763;2156.33153722345;2209.624363858148;2214.446388402899;2230.8661480311234;2255.3459496745922;2255.7857003584795;7261.983322334877;7399.4450416219;7399.85200295991;7403.074615673041;7406.8888966665545;4405.493368262659;4471.39636149119;4507.414036175309;4510.774461276956;4514.5936865681915;2732.8360298381963;2805.368792021799;2808.480431120229;2836.390176112125;2852.358219400618;913.6939125393002;915.9084091590854;922.2253307221898;925.0379605210572;951.357833462417;9721.854172187423;9737.2697047721;9740.220782337467;9748.220142388593;9762.511874406322;3930.567637559866;3966.8809935701397;4009.659178969762;4058.127502586958;4063.065494936181;8414.621342039623;8439.240468357877;8450.450720703135;8450.746477605682;8454.704085356983;4419.867403977886;4434.645228381722;4434.645228381722;4440.777961101932;4444.711093778894;4016.7188296819527;4019.336809426412;4022.2357752027606;4063.4920634920636;4070.9389359159636;3269.395161895057;3298.703116719507;3468.271662950758;3518.1204698825295;3577.338192434408;1121.170333952869;1142.6058009986707;1145.3242586873785;1151.125144889873;1152.6426807689643;1015.7054454208345;1016.8983101689772;1047.2826114111858;1092.579356947581;1298.1691717300935;6741.528093033538;6775.864482710318;6808.046873437723;6810.62541560219;6829.214640316427;1009.6365308489085;1015.040786456806;1019.9914336657009;1115.074488174813;1139.47014638192;5476.479734425223;5579.358373787067;5591.6365436246515;5596.1605759136455;5596.524295434933;8236;8356.498610083414;8371.16288371158;8387.370947178986;8405.243528082501;8287.544185069759;8354.958225208957;8360.623771930277;8372.916270837213;8379.748607541784;6721.193456785217;6722.697478613474;6864.1762988440705;6869.141357330333;6996.19543752475;6816.079829222991;6861.931380686129;6879.552829066095;6904.240533541407;6907.792766217021;7580.54516728998;7921.960390198012;7931.444798864024;7938.64276107565;8043.718469853527;7937.8412431752195;8026.3980201483955;8113.35093192555;8176.959115204386;8188.385871059575;6414.326495718069;6431.163948686641;6492.740290388331;6520.869582608416;6535.183102112236;6222.937770622417;6346.777862774781;6843.110395648733;7002.544834585736;7009.334113259232;6598.868022639424;6602.40578347951;6700.128983232149;6732.865342693217;6772.830679233059;6429.32492088324;6552;6576.605403675603;6604.867902641824;6677.766278180435;6467.191601049869;6495.220573531206;6501.739930402731;6504.642244676399;6510.674466276762;6074.969625151846;6122.632642041492;6123.295820980644;6125.326214116532;6133.815985520441;6211.409916057967;6215.223097112861;6237.906431403442;6243.032329988859;6246.094316324198 05:11:56 INFO - PROCESS | 12428 | |4;prototype.html;315.4778841018116;318.6240236520905;324.79700187382883;326.56077575660726;331.0383336407735;5918.615290006147;5919.88160236795;5997.340292567825;5998.280206375231;6008.609440386383;5904;5909.113632955059;5926.970365148169;5928.6739229342365;5968.462838344548;4352.673549483786;4410.162069206856;4466.12910482456;4612.331211974261;4618.907621847561;4566.337881007268;4578.908421831561;4598.057398233371;4606.470255920562;4609.308603709454;4477.126960242737;4522.299043648223;4548.590626843584;4549.431321084864;4560.407147070876;4302.13957208558;4396.120775844828;4424.358468022118;4475.1944649963;4480.5967462928165;3915.980420097881;3929.1945151243926;3932.547757007952;3937.586553411908;3938.0154961259686;5534.418886016951;5574.60977731559;5594.748236329375;5659.066254068074;5680.005998950167;5191.273221748958;5294.126469132589;5301.734913254322;5303.124984377611;5308.150695888639;6227.408396202399;6243.219597550306;6243.375662433766;6245.406686364788;6249.437550620466;4364.214441400547;4367.912641747179;4383.49589797171;4391.824327026947;4403.493598236212;6531.673416329212;6563.278039415661;6578.835529111762;6580.276169621337;6583.769568065095;4284.207421627009;4412.84555040572;4425.159219748238;4532.546745325507;4535;4465.553444655508;4469.128519938646;4470.284754439274;4474.619657329164;4479.328100784908;5222.529972302511;5223.973880130651;5227.294315267466;5228.163493840967;5230.633855630145;6352.587081839665;6372.4583410409705;6375.3624637536805;6378.489720822416;6384.872302554016;1528.2358820589704;1558.135234944594;1589.1100983449305;1589.4675283779832;1594.8325425830353;1015.2588610314511;1044.3159730376615;1051.232600201857;1061.596593294543;1069.5882085397022;5889.617174883619;5917.911231331534;5919.940800592025;5924.674142922181;5928.081147422156;6443.903341449882;6481.546291759531;6482.57863238888;6485.351464853571;6492.740290388426;5912.024515954819;5915.024021036481;5916.349201587822;5918.112283157475;5922.082077278029;3292.0782180989363;3341.665833416639;3490.5462289902657;3540.1857572757895;3548.3790336690977;6671.1994560652065;6672.065910772496;6673.1992160941;6717.664116794141;6718.462522998148;6709.6980635871505;6750.9873518972545;6753.223379311344;6761.4590832733265;6774.390304872585;6612.570182938093;6660.9000864987065;6710.261871194067;6723.394894459522;6742.831429214309;6566.540342176193;6609.603423794395;6630.138082049302;6636.734530618721;6643.60138391698;6486.772962946275;6488.351164883474;6497.675116244074;6502.414782669393;6513.967430163008;6604.14146160996;6708.396244338033;6724.93275067243;6729.327067293231;6733.293004234485;4457.710248833815;4459.955400445954;4463.37512748209;4468.084042771289;4470.463544374696;6514.218293804774;6549;6587.209534855848;6590.044443555754;6594.208694956636;6249.562530622813;6360.395762402564;6369.554131210771;6387.42513173798;6388.361163883575;6355.396237357444;6364.459020983269;6366.936330636634;6369.394907483782;6376.649284289409;6253.343398943045;6272.027835685476;6274.466670333073;6279.152314437675;6279.623222606659;6184.598001130092;6235.251769787655;6320.6839658016;6425.325340839331;6425.421712045938;6134.877302454015;6187.257529096537;6262.1546091278915;6309.211348581427;6316.242050953915 05:11:56 INFO - PROCESS | 12428 | |5;yui.html;711.7971378157226;789.5539020453443;835.4444294544129;836.84100020996;846.8560344741393;13143.737125257501;13206.735865282713;13335.99980001499;13340.266285354302;13394.06241563091;12185.51257949681;12804;12827.871721282807;12841.807372889414;12863.228206307605;678.2844099475052;684.9726010959556;812.1350761439078;815.4821688227973;833.017039892926;811.1969150540981;813.259933460551;814.5519964019795;822.8272062866805;823.1439303124743;851.3614788908319;852.910444403338;856.0839901305606;858.5578427110012;862.1335557764438;698.6402002968475;707.8902770070647;840.3613253926999;853.0531110467376;853.8761879527434;624.6002558362652;625.5464788028688;626.9122322874802;626.9435750782405;627.6516533324003;12669.936650316782;12682.619521414372;12773.297468639314;12828.743425131539;12840.229586224856;11954.402279886059;12380.504779808796;12433.689157771038;12570.497180112785;12584.182028168232;10131.848022279672;10169.23730720199;10182.745431364201;10375.075921260997;10413.114885234763;3583.6416358363954;3586.3492473032948;3680.1535646801385;3681.815909204529;3728.459373390843;44421.55578444239;44525.332120018225;44640.10719785619;45038.32442513365;45171;9308.581113849894;9595.328327017181;9690;9709.417434953926;9719.930807611157;18163;18313.450596482126;18344.816551834312;18361.71467997254;18368.816311836712;7700.268474494914;7775;7841.960790196013;7876.881846772303;8064.8387032259025;4443.066955939289;4460.397846290774;4543.545645435496;4562.315652652129;4612.377329060534;2922.8100173488656;2976.0774160010465;2985.1641540368732;2986.1937276935105;2989.7309242168308;543.6058857328484;552.4392741367515;554.7974989128938;556.5019307719568;582.446675658118;592.7066102279313;597.1729155120103;597.8595030167907;614.4961131871822;640.852603901096;7960.40296977729;7970.4819186752675;8001.279884810278;8112.797180070427;8135.796605084802;558.770903929387;576.345847463124;598.3956204233755;623.554158776477;627.3820287017285;3721.1999420124803;3873.360895452275;3891.124496988155;3902.35611124167;3923.7449565778134;49033.509664903606;49410.258846117336;49431.50568494341;49875.75062124739;50424.49575504271;46455.76772116186;47263;48287.517124829006;48597.75701121543;49084.26373604399;41445.37831932523;42082.15835683269;42222.78888605537;43291.35062974058;43443.78278108653;8217.876731848908;8545.615447304763;8589.871151932852;8649.394542381973;8951.239144672776;31132.22169445782;31767.523487148173;32427.837860810545;32471;32476;41175.38236926388;41314;41833;41858.162836742486;42203.57796422119;10676.252662313564;10732.53239807962;10863.913608639074;10970.616028438966;11041.447927603427;11677.416129193676;11966.820497692715;12023.879761202626;12096.274223546616;12108;10174.949125254327;10381.636642717469;10382.221333399873;10772.515236814519;10957.50691218913;10623.521941512496;10930;11029.22795404314;11293.491792869176;11321.207515473838;11370;11843.526258949545;11859.58491452795;12225.755484890431;12248.265104093784;9644.807103858024;9734.021988044553;9825.55784989663;9835.803283934138;9930.950345248517;9203.447793132433;9288.674896378594;9289.581968811555;9368.81262374735;9477.431354118775 05:11:56 INFO - PROCESS | 12428 | __end_tp_report 05:11:56 INFO - PROCESS | 12428 | __start_cc_report 05:11:56 INFO - PROCESS | 12428 | _x_x_mozilla_cycle_collect,941 05:11:56 INFO - PROCESS | 12428 | __end_cc_report 05:11:56 INFO - PROCESS | 12428 | __startTimestamp1451567516684__endTimestamp 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | ------- Summary: start ------- 05:11:56 INFO - PROCESS | 12428 | Number of tests: 6 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#0] dojo.html Cycles:165 Average:5296.58 Median:5529.12 stddev:580.01 (10.5%) stddev-sans-first:555.69 05:11:56 INFO - PROCESS | 12428 | Values: 3103.4 3168.7 3217.4 3218.5 3242.7 5152.8 5263.6 5290.0 5329.6 5397.1 5177.6 5298.1 5332.9 5363.1 5396.6 4827.3 4833.5 4834.6 4861.8 4925.5 4822.5 4891.1 4940.1 4943.7 4986.7 4728.4 4742.5 4826.4 4877.5 4877.6 4873.7 4878.2 4881.3 4890.8 4931.9 4836.6 4849.7 4862.8 4864.6 4906.8 5067.3 5129.3 5149.5 5202.6 5236.6 5739.5 5752.9 5755.7 5759.9 5775.3 5758.2 5777.4 5777.7 5781.6 5782.3 5254.8 5318.1 5346.9 5359.2 5378.6 5803.9 5804.6 5807.7 5809.8 5849.7 5542.0 5548.1 5549.8 5576.7 5594.6 5593.7 5628.4 5629.2 5675.9 5700.7 5621.3 5663.0 5670.5 5672.4 5704.0 5667.9 5671.1 5672.0 5673.0 5680.3 4270.0 4358.6 4436.2 4452.9 4458.2 3938.7 3941.2 3941.6 3977.9 3984.5 5295.7 5297.7 5301.2 5304.1 5310.0 5637.9 5719.2 5743.9 5750.4 5834.0 5273.1 5276.6 5277.3 5292.2 5323.0 4951.0 4956.4 4961.4 4967.0 5004.9 5745.0 5821.8 5831.7 5844.0 5875.3 5703.7 5794.9 5800.4 5803.6 5852.9 5840.8 5844.6 5848.9 5854.6 5858.3 5487.0 5582.6 5585.4 5648.9 5653.2 5566.0 5640.7 5658.9 5758.5 5776.2 5625.2 5629.0 5631.4 5631.7 5637.0 5534.6 5616.6 5621.8 5622.2 5624.5 5373.1 5405.8 5493.6 5510.0 5539.9 5654.4 5658.4 5677.1 5684.1 5748.1 5359.4 5516.7 5529.1 5562.9 5572.3 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#1] ext.html Cycles:180 Average:42934.99 Median:176708.50 stddev:70551.00 (39.9%) stddev-sans-first:70677.13 05:11:56 INFO - PROCESS | 12428 | Values: 548.8 551.0 567.1 577.0 604.4 28142.0 28589.1 38663.2 39511.8 39557.2 42630.0 43023.4 43051.1 43072.8 43168.4 7359.5 8666.6 8828.1 8830.6 8842.5 7432.0 10110.2 10272.3 10335.5 10350.6 10035.6 10055.6 10162.1 10168.4 10173.5 7543.3 7706.3 10035.1 10084.1 10165.1 9915.2 9926.3 10043.3 10079.4 10083.4 36397.3 36823.8 36826.1 36839.0 36906.6 3288.9 3309.3 3379.8 3730.2 3876.2 28621.6 28642.9 28694.9 28744.9 29806.0 3901.4 3950.6 3960.7 3968.2 4028.2 259011.0 259398.0 259569.0 260216.0 260374.0 50299.7 51843.7 57577.4 58767.7 59162.4 53456.7 53807.5 54199.2 54214.5 54231.0 15247.7 15428.9 15480.5 15547.2 15551.6 12073.8 12092.9 12140.6 12148.8 12183.0 19264.4 19381.6 19390.8 19417.7 19538.4 7745.2 7915.9 7961.3 8038.4 8067.9 987.2 991.8 1038.2 1051.7 1085.4 27425.3 28179.6 28511.7 28785.7 28955.3 1005.9 1024.7 1056.0 1058.0 1108.1 13296.6 13318.6 13558.0 13572.1 13890.9 321899.0 328153.0 329100.0 330193.0 330834.0 50607.7 50863.2 50903.5 50909.0 50968.7 1352.9 1353.8 1370.8 1372.5 1383.5 25021.7 25781.9 26507.5 26568.5 26738.6 41236.2 41503.6 41619.8 41719.4 41766.8 208112.0 208766.0 209330.0 209722.0 210253.0 27158.7 27628.9 28278.9 30968.0 31518.0 36191.0 36902.3 36906.8 37038.8 37795.0 33137.0 33352.8 34365.7 34828.3 34829.0 30182.0 33416.1 33537.5 34331.5 34393.8 32953.0 33740.5 33832.5 33933.7 34227.7 28869.9 29716.4 30969.7 31197.9 31456.0 23668.8 23676.3 23735.0 23832.6 24011.9 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#2] jquery.html Cycles:180 Average:28890.00 Median:36517.68 stddev:93910.55 (257.2%) stddev-sans-first:94149.51 05:11:56 INFO - PROCESS | 12428 | Values: 332.2 339.7 340.4 341.5 345.5 14540.3 15005.5 16226.4 16271.2 16972.3 16284.2 16521.6 16563.8 16594.2 16779.2 5195.2 5291.1 5328.4 5329.1 5338.3 3975.8 4123.6 5365.7 5692.5 5921.3 5802.2 5839.2 5840.0 5858.4 5858.6 5664.0 5755.3 5805.7 5807.5 5824.2 5072.5 5073.7 5086.3 5089.3 5091.1 20319.8 20696.3 20736.5 20904.6 20937.7 2247.9 2248.2 2323.6 2340.2 2784.0 12874.5 12941.7 12990.8 13391.5 13428.3 1747.8 1761.6 1786.8 1828.8 1847.4 56586.4 58808.1 59035.4 59324.7 59351.4 9046.0 9172.6 9292.6 9441.6 9491.5 12193.4 12232.8 12234.8 12240.0 12248.4 7374.3 7401.4 7539.1 7544.3 7600.5 7203.5 7268.3 7276.6 7339.6 7347.9 5772.9 5821.7 5827.3 5831.3 5871.2 1487.2 1568.6 1585.8 1654.9 1655.9 922.4 1006.4 1014.5 1077.2 1117.0 11148.8 11282.5 11313.8 11584.1 11753.1 430.9 449.6 450.3 458.5 474.3 9322.4 9775.2 10241.3 10441.3 10468.2 569990.0 571014.0 575677.0 580417.0 583308.0 38883.4 39338.0 47159.3 75305.2 84107.6 443.0 450.4 451.3 471.1 485.2 10553.9 10704.3 10729.8 10733.9 10905.0 35435.5 36083.5 36379.5 36395.1 36640.3 47455.5 48055.5 48103.3 48614.0 51127.2 9315.5 9768.0 9774.0 9794.5 9802.3 11303.4 11410.9 12178.9 15619.5 17410.7 13934.7 14179.1 14315.9 14436.6 14481.1 13857.6 14224.2 14441.6 14557.8 14967.4 10462.7 11812.0 14186.4 14631.3 15248.4 9425.6 9568.9 9682.1 9692.3 9780.3 10240.1 12729.9 13842.4 14002.5 14674.9 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#3] mootools.html Cycles:180 Average:5095.91 Median:6296.44 stddev:2585.96 (41.1%) stddev-sans-first:2577.29 05:11:56 INFO - PROCESS | 12428 | Values: 1278.3 1410.7 1418.7 1542.9 1733.6 6392.6 7057.7 7151.9 7154.7 7227.5 7035.8 7178.3 7205.2 7224.9 7232.7 1909.1 1949.3 2162.8 2174.4 2177.1 2148.8 2150.3 2153.5 2156.0 2157.8 2126.9 2252.5 2253.5 2255.2 2257.0 2114.3 2119.4 2147.0 2156.1 2156.3 2209.6 2214.4 2230.9 2255.3 2255.8 7262.0 7399.4 7399.9 7403.1 7406.9 4405.5 4471.4 4507.4 4510.8 4514.6 2732.8 2805.4 2808.5 2836.4 2852.4 913.7 915.9 922.2 925.0 951.4 9721.9 9737.3 9740.2 9748.2 9762.5 3930.6 3966.9 4009.7 4058.1 4063.1 8414.6 8439.2 8450.5 8450.7 8454.7 4419.9 4434.6 4434.6 4440.8 4444.7 4016.7 4019.3 4022.2 4063.5 4070.9 3269.4 3298.7 3468.3 3518.1 3577.3 1121.2 1142.6 1145.3 1151.1 1152.6 1015.7 1016.9 1047.3 1092.6 1298.2 6741.5 6775.9 6808.0 6810.6 6829.2 1009.6 1015.0 1020.0 1115.1 1139.5 5476.5 5579.4 5591.6 5596.2 5596.5 8236.0 8356.5 8371.2 8387.4 8405.2 8287.5 8355.0 8360.6 8372.9 8379.7 6721.2 6722.7 6864.2 6869.1 6996.2 6816.1 6861.9 6879.6 6904.2 6907.8 7580.5 7922.0 7931.4 7938.6 8043.7 7937.8 8026.4 8113.4 8177.0 8188.4 6414.3 6431.2 6492.7 6520.9 6535.2 6222.9 6346.8 6843.1 7002.5 7009.3 6598.9 6602.4 6700.1 6732.9 6772.8 6429.3 6552.0 6576.6 6604.9 6677.8 6467.2 6495.2 6501.7 6504.6 6510.7 6075.0 6122.6 6123.3 6125.3 6133.8 6211.4 6215.2 6237.9 6243.0 6246.1 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#4] prototype.html Cycles:180 Average:5268.58 Median:5921.01 stddev:1604.34 (27.1%) stddev-sans-first:1565.17 05:11:56 INFO - PROCESS | 12428 | Values: 315.5 318.6 324.8 326.6 331.0 5918.6 5919.9 5997.3 5998.3 6008.6 5904.0 5909.1 5927.0 5928.7 5968.5 4352.7 4410.2 4466.1 4612.3 4618.9 4566.3 4578.9 4598.1 4606.5 4609.3 4477.1 4522.3 4548.6 4549.4 4560.4 4302.1 4396.1 4424.4 4475.2 4480.6 3916.0 3929.2 3932.5 3937.6 3938.0 5534.4 5574.6 5594.7 5659.1 5680.0 5191.3 5294.1 5301.7 5303.1 5308.2 6227.4 6243.2 6243.4 6245.4 6249.4 4364.2 4367.9 4383.5 4391.8 4403.5 6531.7 6563.3 6578.8 6580.3 6583.8 4284.2 4412.8 4425.2 4532.5 4535.0 4465.6 4469.1 4470.3 4474.6 4479.3 5222.5 5224.0 5227.3 5228.2 5230.6 6352.6 6372.5 6375.4 6378.5 6384.9 1528.2 1558.1 1589.1 1589.5 1594.8 1015.3 1044.3 1051.2 1061.6 1069.6 5889.6 5917.9 5919.9 5924.7 5928.1 6443.9 6481.5 6482.6 6485.4 6492.7 5912.0 5915.0 5916.3 5918.1 5922.1 3292.1 3341.7 3490.5 3540.2 3548.4 6671.2 6672.1 6673.2 6717.7 6718.5 6709.7 6751.0 6753.2 6761.5 6774.4 6612.6 6660.9 6710.3 6723.4 6742.8 6566.5 6609.6 6630.1 6636.7 6643.6 6486.8 6488.4 6497.7 6502.4 6514.0 6604.1 6708.4 6724.9 6729.3 6733.3 4457.7 4460.0 4463.4 4468.1 4470.5 6514.2 6549.0 6587.2 6590.0 6594.2 6249.6 6360.4 6369.6 6387.4 6388.4 6355.4 6364.5 6366.9 6369.4 6376.6 6253.3 6272.0 6274.5 6279.2 6279.6 6184.6 6235.3 6320.7 6425.3 6425.4 6134.9 6187.3 6262.2 6309.2 6316.2 05:11:56 INFO - PROCESS | 12428 | 05:11:56 INFO - PROCESS | 12428 | [#5] yui.html Cycles:180 Average:13033.57 Median:45104.66 stddev:14465.04 (32.1%) stddev-sans-first:14476.02 05:11:56 INFO - PROCESS | 12428 | Values: 711.8 789.6 835.4 836.8 846.9 13143.7 13206.7 13336.0 13340.3 13394.1 12185.5 12804.0 12827.9 12841.8 12863.2 678.3 685.0 812.1 815.5 833.0 811.2 813.3 814.6 822.8 823.1 851.4 852.9 856.1 858.6 862.1 698.6 707.9 840.4 853.1 853.9 624.6 625.5 626.9 626.9 627.7 12669.9 12682.6 12773.3 12828.7 12840.2 11954.4 12380.5 12433.7 12570.5 12584.2 10131.8 10169.2 10182.7 10375.1 10413.1 3583.6 3586.3 3680.2 3681.8 3728.5 44421.6 44525.3 44640.1 45038.3 45171.0 9308.6 9595.3 9690.0 9709.4 9719.9 18163.0 18313.5 18344.8 18361.7 18368.8 7700.3 7775.0 7842.0 7876.9 8064.8 4443.1 4460.4 4543.5 4562.3 4612.4 2922.8 2976.1 2985.2 2986.2 2989.7 543.6 552.4 554.8 556.5 582.4 592.7 597.2 597.9 614.5 640.9 7960.4 7970.5 8001.3 8112.8 8135.8 558.8 576.3 598.4 623.6 627.4 3721.2 3873.4 3891.1 3902.4 3923.7 49033.5 49410.3 49431.5 49875.8 50424.5 46455.8 47263.0 48287.5 48597.8 49084.3 41445.4 42082.2 42222.8 43291.4 43443.8 8217.9 8545.6 8589.9 8649.4 8951.2 31132.2 31767.5 32427.8 32471.0 32476.0 41175.4 41314.0 41833.0 41858.2 42203.6 10676.3 10732.5 10863.9 10970.6 11041.4 11677.4 11966.8 12023.9 12096.3 12108.0 10174.9 10381.6 10382.2 10772.5 10957.5 10623.5 10930.0 11029.2 11293.5 11321.2 11370.0 11843.5 11859.6 12225.8 12248.3 9644.8 9734.0 9825.6 9835.8 9931.0 9203.4 9288.7 9289.6 9368.8 9477.4 05:11:56 INFO - PROCESS | 12428 | -------- Summary: end -------- 05:11:56 INFO - PROCESS | 12428 | 05:11:57 INFO - TEST-INFO | 12428: exit 0 05:11:57 INFO - TEST-OK | dromaeo_css | took 1113932ms 05:11:57 INFO - TEST-START | kraken 05:11:57 INFO - operating with platform_type : linux_ 05:11:57 INFO - Initialising browser for kraken test... 05:11:57 INFO - TEST-INFO | started process 12626 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ1kd1Q/profile http://localhost:37881/getInfo.html) 05:12:01 INFO - PROCESS | 12626 | __metrics Screen width/height:1600/1200 05:12:01 INFO - PROCESS | 12626 | colorDepth:24 05:12:01 INFO - PROCESS | 12626 | Browser inner width/height: 1024/697 05:12:01 INFO - PROCESS | 12626 | __metrics 05:12:01 INFO - PROCESS | 12626 | 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:12:01 INFO - PROCESS | 12626 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:02 INFO - TEST-INFO | 12626: exit 0 05:12:02 INFO - Browser initialized. 05:12:02 INFO - Running cycle 1/1 for kraken test... 05:12:02 INFO - TEST-INFO | started process 12708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ1kd1Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:14 INFO - PROCESS | 12708 | RSS: Main: 149352448 05:12:14 INFO - PROCESS | 12708 | 05:12:17 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37881/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:17 INFO - PROCESS | 12708 | RSS: Main: 183533568 05:12:17 INFO - PROCESS | 12708 | 05:12:20 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37881/tests/kraken/driver.html?testName=audio-dft) 05:12:20 INFO - PROCESS | 12708 | RSS: Main: 173355008 05:12:20 INFO - PROCESS | 12708 | 05:12:23 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37881/tests/kraken/driver.html?testName=audio-fft) 05:12:24 INFO - PROCESS | 12708 | RSS: Main: 161468416 05:12:24 INFO - PROCESS | 12708 | 05:12:26 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37881/tests/kraken/driver.html?testName=audio-oscillator) 05:12:27 INFO - PROCESS | 12708 | RSS: Main: 162222080 05:12:27 INFO - PROCESS | 12708 | 05:12:29 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:29 INFO - PROCESS | 12708 | RSS: Main: 164831232 05:12:29 INFO - PROCESS | 12708 | 05:12:32 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37881/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:33 INFO - PROCESS | 12708 | RSS: Main: 163942400 05:12:33 INFO - PROCESS | 12708 | 05:12:36 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37881/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:37 INFO - PROCESS | 12708 | RSS: Main: 165306368 05:12:37 INFO - PROCESS | 12708 | 05:12:39 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37881/tests/kraken/driver.html?testName=json-parse-financial) 05:12:40 INFO - PROCESS | 12708 | RSS: Main: 166866944 05:12:40 INFO - PROCESS | 12708 | 05:12:42 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:42 INFO - PROCESS | 12708 | RSS: Main: 177012736 05:12:42 INFO - PROCESS | 12708 | 05:12:44 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:45 INFO - PROCESS | 12708 | RSS: Main: 174489600 05:12:45 INFO - PROCESS | 12708 | 05:12:47 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:47 INFO - PROCESS | 12708 | RSS: Main: 185896960 05:12:47 INFO - PROCESS | 12708 | 05:12:50 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:50 INFO - PROCESS | 12708 | RSS: Main: 191844352 05:12:50 INFO - PROCESS | 12708 | 05:12:53 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:53 INFO - PROCESS | 12708 | RSS: Main: 189665280 05:12:53 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | Cycle 1(1): loaded http://localhost:37881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37881/tests/kraken/driver.html?testName=ai-astar) 05:12:55 INFO - PROCESS | 12708 | RSS: Main: 247689216 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | __start_tp_report 05:12:55 INFO - PROCESS | 12708 | _x_x_mozilla_page_load 05:12:55 INFO - PROCESS | 12708 | _x_x_mozilla_page_load_details 05:12:55 INFO - PROCESS | 12708 | |i|pagename|runs| 05:12:55 INFO - PROCESS | 12708 | |0;ai-astar;110;112;106;111;111;111;101;111;110;103 05:12:55 INFO - PROCESS | 12708 | |1;audio-beat-detection;148;126;152;169;135;160;149;128;163;127 05:12:55 INFO - PROCESS | 12708 | |2;audio-dft;161;163;162;163;162;162;161;160;161;160 05:12:55 INFO - PROCESS | 12708 | |3;audio-fft;72;73;85;97;71;74;71;110;92;72 05:12:55 INFO - PROCESS | 12708 | |4;audio-oscillator;97;96;150;96;96;96;143;97;98;135 05:12:55 INFO - PROCESS | 12708 | |5;imaging-gaussian-blur;109;109;110;110;109;109;109;110;109;109 05:12:55 INFO - PROCESS | 12708 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;146;146 05:12:55 INFO - PROCESS | 12708 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;96;96 05:12:55 INFO - PROCESS | 12708 | |8;json-parse-financial;61;59;58;57;59;57;58;68;55;56 05:12:55 INFO - PROCESS | 12708 | |9;json-stringify-tinderbox;68;67;67;67;69;68;68;67;68;68 05:12:55 INFO - PROCESS | 12708 | |10;stanford-crypto-aes;85;85;86;93;85;85;86;87;85;87 05:12:55 INFO - PROCESS | 12708 | |11;stanford-crypto-ccm;118;118;116;121;120;118;121;116;116;120 05:12:55 INFO - PROCESS | 12708 | |12;stanford-crypto-pbkdf2;141;143;154;150;152;142;153;155;150;141 05:12:55 INFO - PROCESS | 12708 | |13;stanford-crypto-sha256-iterative;68;68;70;69;68;67;67;69;75;68 05:12:55 INFO - PROCESS | 12708 | __end_tp_report 05:12:55 INFO - PROCESS | 12708 | __start_cc_report 05:12:55 INFO - PROCESS | 12708 | _x_x_mozilla_cycle_collect,920 05:12:55 INFO - PROCESS | 12708 | __end_cc_report 05:12:55 INFO - PROCESS | 12708 | __startTimestamp1451567575773__endTimestamp 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | ------- Summary: start ------- 05:12:55 INFO - PROCESS | 12708 | Number of tests: 14 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.07 05:12:55 INFO - PROCESS | 12708 | Values: 110.0 112.0 106.0 111.0 111.0 111.0 101.0 111.0 110.0 103.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:150.50 stddev:15.87 (10.5%) stddev-sans-first:16.82 05:12:55 INFO - PROCESS | 12708 | Values: 148.0 126.0 152.0 169.0 135.0 160.0 149.0 128.0 163.0 127.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:12:55 INFO - PROCESS | 12708 | Values: 161.0 163.0 162.0 163.0 162.0 162.0 161.0 160.0 161.0 160.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.50 stddev:13.76 (18.7%) stddev-sans-first:14.14 05:12:55 INFO - PROCESS | 12708 | Values: 72.0 73.0 85.0 97.0 71.0 74.0 71.0 110.0 92.0 72.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:22.55 (23.5%) stddev-sans-first:23.40 05:12:55 INFO - PROCESS | 12708 | Values: 97.0 96.0 150.0 96.0 96.0 96.0 143.0 97.0 98.0 135.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:12:55 INFO - PROCESS | 12708 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:12:55 INFO - PROCESS | 12708 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:12:55 INFO - PROCESS | 12708 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.50 stddev:3.65 (6.2%) stddev-sans-first:3.78 05:12:55 INFO - PROCESS | 12708 | Values: 61.0 59.0 58.0 57.0 59.0 57.0 58.0 68.0 55.0 56.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:12:55 INFO - PROCESS | 12708 | Values: 68.0 67.0 67.0 67.0 69.0 68.0 68.0 67.0 68.0 68.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.46 (2.9%) stddev-sans-first:2.55 05:12:55 INFO - PROCESS | 12708 | Values: 85.0 85.0 86.0 93.0 85.0 85.0 86.0 87.0 85.0 87.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.00 stddev:2.01 (1.7%) stddev-sans-first:2.13 05:12:55 INFO - PROCESS | 12708 | Values: 118.0 118.0 116.0 121.0 120.0 118.0 121.0 116.0 116.0 120.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:151.00 stddev:5.70 (3.8%) stddev-sans-first:5.44 05:12:55 INFO - PROCESS | 12708 | Values: 141.0 143.0 154.0 150.0 152.0 142.0 153.0 155.0 150.0 141.0 05:12:55 INFO - PROCESS | 12708 | 05:12:55 INFO - PROCESS | 12708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.33 (3.4%) stddev-sans-first:2.45 05:12:55 INFO - PROCESS | 12708 | Values: 68.0 68.0 70.0 69.0 68.0 67.0 67.0 69.0 75.0 68.0 05:12:55 INFO - PROCESS | 12708 | -------- Summary: end -------- 05:12:55 INFO - PROCESS | 12708 | 05:12:56 INFO - TEST-INFO | 12708: exit 0 05:12:56 INFO - TEST-OK | kraken | took 59170ms 05:12:56 INFO - TEST-START | v8_7 05:12:56 INFO - operating with platform_type : linux_ 05:12:56 INFO - Initialising browser for v8_7 test... 05:12:56 INFO - TEST-INFO | started process 12958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYgYYNs/profile http://localhost:37881/getInfo.html) 05:13:01 INFO - PROCESS | 12958 | __metrics Screen width/height:1600/1200 05:13:01 INFO - PROCESS | 12958 | colorDepth:24 05:13:01 INFO - PROCESS | 12958 | Browser inner width/height: 1024/697 05:13:01 INFO - PROCESS | 12958 | __metrics 05:13:01 INFO - PROCESS | 12958 | 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:13:01 INFO - PROCESS | 12958 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:02 INFO - TEST-INFO | 12958: exit 0 05:13:02 INFO - Browser initialized. 05:13:02 INFO - Running cycle 1/1 for v8_7 test... 05:13:02 INFO - TEST-INFO | started process 13045 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYgYYNs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:13 INFO - PROCESS | 13045 | RSS: Main: 149467136 05:13:13 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | Cycle 1(1): loaded http://localhost:37881/tests/v8_7/run.html (next: http://localhost:37881/tests/v8_7/run.html) 05:13:35 INFO - PROCESS | 13045 | RSS: Main: 584093696 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | __start_tp_report 05:13:35 INFO - PROCESS | 13045 | _x_x_mozilla_page_load 05:13:35 INFO - PROCESS | 13045 | _x_x_mozilla_page_load_details 05:13:35 INFO - PROCESS | 13045 | |i|pagename|runs| 05:13:35 INFO - PROCESS | 13045 | |0;Richards;167.9261125104954 05:13:35 INFO - PROCESS | 13045 | |1;DeltaBlue;191.20458891013385 05:13:35 INFO - PROCESS | 13045 | |2;Encrypt;281.135788585887 05:13:35 INFO - PROCESS | 13045 | |3;Decrypt;5175.257731958763 05:13:35 INFO - PROCESS | 13045 | |4;RayTrace;1956.9471624266146 05:13:35 INFO - PROCESS | 13045 | |5;Earley;803.8585209003215 05:13:35 INFO - PROCESS | 13045 | |6;Boyer;12378.048780487805 05:13:35 INFO - PROCESS | 13045 | |7;RegExp;26842.105263157893 05:13:35 INFO - PROCESS | 13045 | |8;Splay;672.4949562878278 05:13:35 INFO - PROCESS | 13045 | |9;NavierStokes;4830.917874396136 05:13:35 INFO - PROCESS | 13045 | __end_tp_report 05:13:35 INFO - PROCESS | 13045 | __startTimestamp1451567615547__endTimestamp 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | ------- Summary: start ------- 05:13:35 INFO - PROCESS | 13045 | Number of tests: 10 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#0] Richards Cycles:1 Average:167.93 Median:167.93 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 167.9 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 191.2 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 281.1 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 5175.3 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 1956.9 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 803.9 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#6] Boyer Cycles:1 Average:12378.05 Median:12378.05 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 12378.0 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 26842.1 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#8] Splay Cycles:1 Average:672.49 Median:672.49 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 672.5 05:13:35 INFO - PROCESS | 13045 | 05:13:35 INFO - PROCESS | 13045 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:13:35 INFO - PROCESS | 13045 | Values: 4830.9 05:13:35 INFO - PROCESS | 13045 | -------- Summary: end -------- 05:13:35 INFO - PROCESS | 13045 | 05:13:36 INFO - TEST-INFO | 13045: exit 0 05:13:36 INFO - TEST-OK | v8_7 | took 39792ms 05:13:36 INFO - SUITE-END | took 1212s 05:13:36 INFO - Completed test suite (00:20:13) 05:13:36 INFO - Working with test: dromaeo_css 05:13:36 INFO - Generating results file: dromaeo_css 05:13:36 INFO - Working with test: kraken 05:13:36 INFO - Generating results file: kraken 05:13:36 INFO - javascript benchmark 05:13:36 INFO - Working with test: v8_7 05:13:36 INFO - Generating results file: v8_7 05:13:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:13:36 INFO - process_Request line: dromaeo_css 6761.24 graph.html#tests=[[72,201,35]] 05:13:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:36 INFO - process_Request line: kraken 1507.20 graph.html#tests=[[232,201,35]] 05:13:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:36 INFO - process_Request line: v8_7 19476.21 graph.html#tests=[[230,201,35]] 05:13:36 INFO - RETURN: dromaeo_css: 6761.24 05:13:36 INFO - RETURN: kraken: 1507.20 05:13:36 INFO - RETURN: v8_7: 19476.21 05:13:36 INFO - javascript benchmark 05:13:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.441380551501, 3168.6989735975103, 3217.388696147732, 3218.533312669663, 3242.724368428684, 5152.845414637558, 5263.552598029172, 5289.973550132248, 5329.626926115174, 5397.136458166694, 5177.5599074078655, 5298.09932311507, 5332.92000619991, 5363.061464243761, 5396.622236443451, 4827.3000414939725, 4833.468318484964, 4834.613230941516, 4861.829835955742, 4925.507449255064, 4822.517748225185, 4891.095147397743, 4940.110780059588, 4943.6539442239055, 4986.650934434591, 4728.40894888139, 4742.478327383985, 4826.444958829709, 4877.487863774306, 4877.561019508261, 4873.658843880929, 4878.219484882402, 4881.292212629149, 4890.8043678252825, 4931.926021109686, 4836.637252206064, 4849.733264670442, 4862.805487780484, 4864.586510146642, 4906.803727850882, 5067.290579318898, 5129.25625784263, 5149.510796474329, 5202.635815492917, 5236.607254455931, 5739.454751798572, 5752.8849423011725, 5755.712214389264, 5759.942400575983, 5775.306963164448, 5758.165066065439, 5777.393373695743, 5777.682227477487, 5781.595288329819, 5782.277215348082, 5254.789808407697, 5318.069337865858, 5346.91979620306, 5359.249705041337, 5378.623496355257, 5803.9419605803405, 5804.622699524517, 5807.651540907559, 5809.796657116981, 5849.736761845727, 5541.972290138604, 5548.112302031655, 5549.778008879681, 5576.722040834568, 5594.636348637326, 5593.664380137205, 5628.437156284421, 5629.211910332557, 5675.858103547444, 5700.714964251771, 5621.297337832771, 5662.971685141548, 5670.461306175989, 5672.404397538282, 5704.0, 5667.8866422672145, 5671.120976248606, 5672.035753921843, 5672.97163514188, 5680.289963754531, 4269.957300426956, 4358.629516491071, 4436.157130145262, 4452.933206001912, 4458.152950939311, 3938.724289299779, 3941.2117576484816, 3941.6058394160927, 3977.9204415911518, 3984.5218573770753, 5295.682259064469, 5297.65565238266, 5301.204819277139, 5304.098303288451, 5310.0, 5637.943620563742, 5719.170720245541, 5743.885122297531, 5750.424957504216, 5834.0, 5273.077211487975, 5276.604254680914, 5277.340332458442, 5292.20616907467, 5323.041852466593, 4950.950490495121, 4956.405231372259, 4961.4294356148785, 4966.975165124151, 5004.874878128076, 5744.971275143597, 5821.76712931478, 5831.708414579254, 5844.0, 5875.3243377012195, 5703.714814259188, 5794.942050579609, 5800.419958004166, 5803.564732644984, 5852.853678658068, 5840.766369345179, 5844.620099693507, 5848.853778655397, 5854.590178687451, 5858.297004359334, 5487.039768040497, 5582.637128586629, 5585.357683866245, 5648.915266271091, 5653.152027195953, 5566.0, 5640.689762063126, 5658.9151162733415, 5758.539316854558, 5776.220210271727, 5625.240592520121, 5629.043062679272, 5631.436856314336, 5631.746571404215, 5637.041702910433, 5534.612577119724, 5616.578756593353, 5621.831345059655, 5622.2128901954575, 5624.465675760796, 5373.11343628297, 5405.78376864921, 5493.560515158858, 5510.035743744908, 5539.944600553943, 5654.378018418053, 5658.377578466448, 5677.148427735872, 5684.062129748545, 5748.109043098327, 5359.383670877899, 5516.668999860021, 5529.115341545495, 5562.944370556243, 5572.331320241597], "unit": "score", "name": "dojo.html", "value": 5259.38071614525}, {"lowerIsBetter": false, "replicates": [548.7942021741846, 551.0494397164891, 567.135118943611, 576.9672286606974, 604.4137186928681, 28142.0, 28589.142325730234, 38663.22673546527, 39511.802440987754, 39557.208855822864, 42630.0, 43023.35464968028, 43051.138977220435, 43072.78463607677, 43168.352474712905, 7359.521631093989, 8666.610002549869, 8828.117188281152, 8830.602622881954, 8842.513661748633, 7432.0, 10110.191184705243, 10272.33229840058, 10335.534900929439, 10350.637727679532, 10035.648752293635, 10055.597776088984, 10162.08541231289, 10168.44073575953, 10173.491325433699, 7543.321101100927, 7706.306432421109, 10035.096841284283, 10084.14284785794, 10165.085142337151, 9915.206783457379, 9926.255530835217, 10043.296969212159, 10079.44563049032, 10083.394996300245, 36397.27205455903, 36823.815880920694, 36826.07934801625, 36839.0, 36906.63093369059, 3288.8684452621865, 3309.271960168759, 3379.8141102239365, 3730.1607138393915, 3876.2247550489733, 28621.57067643987, 28642.856785716147, 28694.856525717445, 28744.856275718488, 29806.0, 3901.3757798752063, 3950.644442000234, 3960.722749407543, 3968.226195891802, 4028.174224284044, 259011.0, 259398.0, 259569.0, 260215.9999999981, 260374.0, 50299.74850125799, 51843.740781296605, 57577.424225757204, 58767.706161468916, 59162.40837591569, 53456.73271633695, 53807.46192538103, 54199.18701219406, 54214.457855420944, 54231.0, 15247.695046099016, 15428.922855385652, 15480.458183963507, 15547.222638868237, 15551.611209719847, 12073.758524829454, 12092.939535302266, 12140.635780926586, 12148.757024859453, 12183.02535797134, 19264.422067338, 19381.61236775285, 19390.8060919389, 19417.708734368996, 19538.413847584594, 7745.204849623757, 7915.881261781078, 7961.328121094635, 8038.397120216007, 8067.919320806717, 987.170776547689, 991.7520619845038, 1038.231708535678, 1051.726551096705, 1085.375908852413, 27425.31436714098, 28179.577306340423, 28511.71488285132, 28785.71214287872, 28955.276118097216, 1005.894381089975, 1024.7284469615558, 1056.0, 1057.9947100264449, 1108.0692218536467, 13296.601101966957, 13318.600441986757, 13558.0, 13572.117812342167, 13890.861091389159, 321899.0, 328153.0, 329100.0, 330193.0, 330834.0, 50607.74696126496, 50863.23705144426, 50903.49096509062, 50908.99999999926, 50968.74515627472, 1352.9323533823467, 1353.810466534686, 1370.8012338210904, 1372.5196181336453, 1383.4535358533524, 25021.74978250194, 25781.87109064443, 26507.469850602494, 26568.468630627667, 26738.59892101659, 41236.175276494905, 41503.58496414997, 41619.7919010403, 41719.37420938749, 41766.79116604398, 208112.0, 208766.0, 209330.0, 209722.0, 210253.0, 27158.72841271641, 27628.861855690593, 28278.85860570684, 30968.0, 31518.0, 36191.0, 36902.26195476129, 36906.8154659225, 37038.814805925795, 37795.0, 33137.0, 33352.83323583366, 34365.65634343625, 34828.303433930676, 34829.0, 30182.0, 33416.09058698165, 33537.49693754547, 34331.485027724106, 34393.82803085969, 32953.0, 33740.49389259212, 33832.49251261282, 33933.66066339404, 34227.657723422446, 28869.855650722453, 29716.405671886874, 30969.70029805455, 31197.908073217328, 31456.0, 23668.763312367344, 23676.289711308687, 23734.978889250033, 23832.642510362013, 24011.879940600884], "unit": "score", "name": "ext.html", "value": 17946.888521571153}, {"lowerIsBetter": false, "replicates": [332.1745462525625, 339.7078512479269, 340.3839051317115, 341.4724251032155, 345.5456075261032, 14540.345684444199, 15005.549833504985, 16226.432074877383, 16271.186440677962, 16972.321107155698, 16284.185790710446, 16521.586960325996, 16563.751543726823, 16594.17029148544, 16779.161041947886, 5195.168772996321, 5291.074062039147, 5328.360596728398, 5329.147336426173, 5338.332708411449, 3975.8210880510446, 4123.628873401393, 5365.731713414333, 5692.544596432296, 5921.319048309457, 5802.216700745409, 5839.240898683165, 5840.0, 5858.414158584129, 5858.619189752674, 5664.0, 5755.3381361143165, 5805.7387417566315, 5807.535397168238, 5824.184614154022, 5072.518110779507, 5073.670211436245, 5086.338775959139, 5089.287499750001, 5091.083604951107, 20319.79680203194, 20696.275630353015, 20736.48158796042, 20904.5819083619, 20937.685934710993, 2247.9213227536957, 2248.190651365507, 2323.6282194848914, 2340.239422187779, 2783.983845896233, 12874.549390771372, 12941.741165176643, 12990.805137922938, 13391.464341426428, 13428.261445620486, 1747.770395642548, 1761.5772214668516, 1786.8213178682029, 1828.789689185734, 1847.4043968224667, 56586.43413565853, 58808.11787823186, 59035.40964590342, 59324.703376483274, 59351.40648593502, 9046.0, 9172.587233574504, 9292.62829486813, 9441.575129119068, 9491.52881303399, 12193.39033048344, 12232.755344893052, 12234.81647775284, 12240.0, 12248.44881980313, 7374.33630973215, 7401.407887368998, 7539.0576177977755, 7544.283293087148, 7600.467967242351, 7203.459740519482, 7268.345848873627, 7276.63616819157, 7339.633018349061, 7347.88978165328, 5772.913406298909, 5821.7380217890295, 5827.271591051119, 5831.329397119385, 5871.236739223959, 1487.2192099147817, 1568.647054412748, 1585.7542080977466, 1654.9172541372884, 1655.9337626494805, 922.3866129024124, 1006.4011912911806, 1014.4724743133529, 1077.175960390302, 1116.9944150279196, 11148.832767508495, 11282.492287847066, 11313.773724525463, 11584.131190160771, 11753.118516111326, 430.90950900310656, 449.6223172535021, 450.31776858059413, 458.47046661106475, 474.34066647360197, 9322.394044387092, 9775.217982561378, 10241.334313269614, 10441.321314114559, 10468.162546996375, 569990.0, 571014.0, 575677.0, 580417.0, 583308.0, 38883.416748748794, 39338.01654958592, 47159.29261061087, 75305.24694752983, 84107.5794621023, 442.97120687155234, 450.4347044459248, 451.3117495818837, 471.14722352541327, 485.22121994199506, 10553.947230263799, 10704.250702451065, 10729.785404292026, 10733.892661073289, 10905.018548330689, 35435.468467973515, 36083.45874811932, 36379.45430818487, 36395.09012274714, 36640.267194655426, 47455.52544474511, 48055.519444805104, 48103.27845082257, 48614.0, 51127.2330915044, 9315.534223288943, 9768.0, 9773.951130244302, 9794.461304628314, 9802.313838031268, 11303.378314192469, 11410.885891140982, 12178.939105304416, 15619.453319133776, 17410.738838917172, 13934.651633709238, 14179.14925104497, 14315.928420357832, 14436.566902992927, 14481.131132132106, 13857.584272471842, 14224.217668027944, 14441.638959026108, 14557.781633275297, 14967.40130394772, 10462.738431539272, 11812.0, 14186.432542698176, 14631.341589628706, 15248.3900643973, 9425.622975081194, 9568.904310956801, 9682.080202380763, 9692.273079518924, 9780.315377923476, 10240.078392944672, 12729.936350318188, 13842.4463021478, 14002.509912153026, 14674.853251467348], "unit": "score", "name": "jquery.html", "value": 8276.845901595638}, {"lowerIsBetter": false, "replicates": [1278.316100886026, 1410.696700209455, 1418.7020725647612, 1542.8842836787237, 1733.5579427246043, 6392.584482008666, 7057.717691292349, 7151.856962860739, 7154.678039488216, 7227.530210536312, 7035.824104397393, 7178.318059784325, 7205.243449437812, 7224.891626625605, 7232.710691572331, 1909.102721720789, 1949.337225343383, 2162.7996461963644, 2174.423777698911, 2177.085624037908, 2148.8280937525037, 2150.290404166621, 2153.5369895472472, 2156.008236211345, 2157.8273738100993, 2126.9042893069773, 2252.481929156295, 2253.5380247049397, 2255.1994042114975, 2257.0294773247497, 2114.302280247515, 2119.4171602809197, 2146.957060858782, 2156.0728886578763, 2156.33153722345, 2209.624363858148, 2214.446388402899, 2230.8661480311234, 2255.3459496745922, 2255.7857003584795, 7261.983322334877, 7399.4450416219, 7399.85200295991, 7403.074615673041, 7406.8888966665545, 4405.493368262659, 4471.39636149119, 4507.414036175309, 4510.774461276956, 4514.5936865681915, 2732.8360298381963, 2805.368792021799, 2808.480431120229, 2836.390176112125, 2852.358219400618, 913.6939125393002, 915.9084091590854, 922.2253307221898, 925.0379605210572, 951.357833462417, 9721.854172187423, 9737.2697047721, 9740.220782337467, 9748.220142388593, 9762.511874406322, 3930.567637559866, 3966.8809935701397, 4009.659178969762, 4058.127502586958, 4063.065494936181, 8414.621342039623, 8439.240468357877, 8450.450720703135, 8450.746477605682, 8454.704085356983, 4419.867403977886, 4434.645228381722, 4434.645228381722, 4440.777961101932, 4444.711093778894, 4016.7188296819527, 4019.336809426412, 4022.2357752027606, 4063.4920634920636, 4070.9389359159636, 3269.395161895057, 3298.703116719507, 3468.271662950758, 3518.1204698825295, 3577.338192434408, 1121.170333952869, 1142.6058009986707, 1145.3242586873785, 1151.125144889873, 1152.6426807689643, 1015.7054454208345, 1016.8983101689772, 1047.2826114111858, 1092.579356947581, 1298.1691717300935, 6741.528093033538, 6775.864482710318, 6808.046873437723, 6810.62541560219, 6829.214640316427, 1009.6365308489085, 1015.040786456806, 1019.9914336657009, 1115.074488174813, 1139.47014638192, 5476.479734425223, 5579.358373787067, 5591.6365436246515, 5596.1605759136455, 5596.524295434933, 8236.0, 8356.498610083414, 8371.16288371158, 8387.370947178986, 8405.243528082501, 8287.544185069759, 8354.958225208957, 8360.623771930277, 8372.916270837213, 8379.748607541784, 6721.193456785217, 6722.697478613474, 6864.1762988440705, 6869.141357330333, 6996.19543752475, 6816.079829222991, 6861.931380686129, 6879.552829066095, 6904.240533541407, 6907.792766217021, 7580.54516728998, 7921.960390198012, 7931.444798864024, 7938.64276107565, 8043.718469853527, 7937.8412431752195, 8026.3980201483955, 8113.35093192555, 8176.959115204386, 8188.385871059575, 6414.326495718069, 6431.163948686641, 6492.740290388331, 6520.869582608416, 6535.183102112236, 6222.937770622417, 6346.777862774781, 6843.110395648733, 7002.544834585736, 7009.334113259232, 6598.868022639424, 6602.40578347951, 6700.128983232149, 6732.865342693217, 6772.830679233059, 6429.32492088324, 6552.0, 6576.605403675603, 6604.867902641824, 6677.766278180435, 6467.191601049869, 6495.220573531206, 6501.739930402731, 6504.642244676399, 6510.674466276762, 6074.969625151846, 6122.632642041492, 6123.295820980644, 6125.326214116532, 6133.815985520441, 6211.409916057967, 6215.223097112861, 6237.906431403442, 6243.032329988859, 6246.094316324198], "unit": "score", "name": "mootools.html", "value": 4211.723981836443}, {"lowerIsBetter": false, "replicates": [315.4778841018116, 318.6240236520905, 324.79700187382883, 326.56077575660726, 331.0383336407735, 5918.615290006147, 5919.88160236795, 5997.340292567825, 5998.280206375231, 6008.609440386383, 5904.0, 5909.113632955059, 5926.970365148169, 5928.6739229342365, 5968.462838344548, 4352.673549483786, 4410.162069206856, 4466.12910482456, 4612.331211974261, 4618.907621847561, 4566.337881007268, 4578.908421831561, 4598.057398233371, 4606.470255920562, 4609.308603709454, 4477.126960242737, 4522.299043648223, 4548.590626843584, 4549.431321084864, 4560.407147070876, 4302.13957208558, 4396.120775844828, 4424.358468022118, 4475.1944649963, 4480.5967462928165, 3915.980420097881, 3929.1945151243926, 3932.547757007952, 3937.586553411908, 3938.0154961259686, 5534.418886016951, 5574.60977731559, 5594.748236329375, 5659.066254068074, 5680.005998950167, 5191.273221748958, 5294.126469132589, 5301.734913254322, 5303.124984377611, 5308.150695888639, 6227.408396202399, 6243.219597550306, 6243.375662433766, 6245.406686364788, 6249.437550620466, 4364.214441400547, 4367.912641747179, 4383.49589797171, 4391.824327026947, 4403.493598236212, 6531.673416329212, 6563.278039415661, 6578.835529111762, 6580.276169621337, 6583.769568065095, 4284.207421627009, 4412.84555040572, 4425.159219748238, 4532.546745325507, 4535.0, 4465.553444655508, 4469.128519938646, 4470.284754439274, 4474.619657329164, 4479.328100784908, 5222.529972302511, 5223.973880130651, 5227.294315267466, 5228.163493840967, 5230.633855630145, 6352.587081839665, 6372.4583410409705, 6375.3624637536805, 6378.489720822416, 6384.872302554016, 1528.2358820589704, 1558.135234944594, 1589.1100983449305, 1589.4675283779832, 1594.8325425830353, 1015.2588610314511, 1044.3159730376615, 1051.232600201857, 1061.596593294543, 1069.5882085397022, 5889.617174883619, 5917.911231331534, 5919.940800592025, 5924.674142922181, 5928.081147422156, 6443.903341449882, 6481.546291759531, 6482.57863238888, 6485.351464853571, 6492.740290388426, 5912.024515954819, 5915.024021036481, 5916.349201587822, 5918.112283157475, 5922.082077278029, 3292.0782180989363, 3341.665833416639, 3490.5462289902657, 3540.1857572757895, 3548.3790336690977, 6671.1994560652065, 6672.065910772496, 6673.1992160941, 6717.664116794141, 6718.462522998148, 6709.6980635871505, 6750.9873518972545, 6753.223379311344, 6761.4590832733265, 6774.390304872585, 6612.570182938093, 6660.9000864987065, 6710.261871194067, 6723.394894459522, 6742.831429214309, 6566.540342176193, 6609.603423794395, 6630.138082049302, 6636.734530618721, 6643.60138391698, 6486.772962946275, 6488.351164883474, 6497.675116244074, 6502.414782669393, 6513.967430163008, 6604.14146160996, 6708.396244338033, 6724.93275067243, 6729.327067293231, 6733.293004234485, 4457.710248833815, 4459.955400445954, 4463.37512748209, 4468.084042771289, 4470.463544374696, 6514.218293804774, 6549.0, 6587.209534855848, 6590.044443555754, 6594.208694956636, 6249.562530622813, 6360.395762402564, 6369.554131210771, 6387.42513173798, 6388.361163883575, 6355.396237357444, 6364.459020983269, 6366.936330636634, 6369.394907483782, 6376.649284289409, 6253.343398943045, 6272.027835685476, 6274.466670333073, 6279.152314437675, 6279.623222606659, 6184.598001130092, 6235.251769787655, 6320.6839658016, 6425.325340839331, 6425.421712045938, 6134.877302454015, 6187.257529096537, 6262.1546091278915, 6309.211348581427, 6316.242050953915], "unit": "score", "name": "prototype.html", "value": 4741.237841680923}, {"lowerIsBetter": false, "replicates": [711.7971378157226, 789.5539020453443, 835.4444294544129, 836.84100020996, 846.8560344741393, 13143.737125257501, 13206.735865282713, 13335.99980001499, 13340.266285354302, 13394.06241563091, 12185.51257949681, 12804.0, 12827.871721282807, 12841.807372889414, 12863.228206307605, 678.2844099475052, 684.9726010959556, 812.1350761439078, 815.4821688227973, 833.017039892926, 811.1969150540981, 813.259933460551, 814.5519964019795, 822.8272062866805, 823.1439303124743, 851.3614788908319, 852.910444403338, 856.0839901305606, 858.5578427110012, 862.1335557764438, 698.6402002968475, 707.8902770070647, 840.3613253926999, 853.0531110467376, 853.8761879527434, 624.6002558362652, 625.5464788028688, 626.9122322874802, 626.9435750782405, 627.6516533324003, 12669.936650316782, 12682.619521414372, 12773.297468639314, 12828.743425131539, 12840.229586224856, 11954.402279886059, 12380.504779808796, 12433.689157771038, 12570.497180112785, 12584.182028168232, 10131.848022279672, 10169.23730720199, 10182.745431364201, 10375.075921260997, 10413.114885234763, 3583.6416358363954, 3586.3492473032948, 3680.1535646801385, 3681.815909204529, 3728.459373390843, 44421.55578444239, 44525.332120018225, 44640.10719785619, 45038.32442513365, 45171.0, 9308.581113849894, 9595.328327017181, 9690.0, 9709.417434953926, 9719.930807611157, 18163.0, 18313.450596482126, 18344.816551834312, 18361.71467997254, 18368.816311836712, 7700.268474494914, 7775.0, 7841.960790196013, 7876.881846772303, 8064.8387032259025, 4443.066955939289, 4460.397846290774, 4543.545645435496, 4562.315652652129, 4612.377329060534, 2922.8100173488656, 2976.0774160010465, 2985.1641540368732, 2986.1937276935105, 2989.7309242168308, 543.6058857328484, 552.4392741367515, 554.7974989128938, 556.5019307719568, 582.446675658118, 592.7066102279313, 597.1729155120103, 597.8595030167907, 614.4961131871822, 640.852603901096, 7960.40296977729, 7970.4819186752675, 8001.279884810278, 8112.797180070427, 8135.796605084802, 558.770903929387, 576.345847463124, 598.3956204233755, 623.554158776477, 627.3820287017285, 3721.1999420124803, 3873.360895452275, 3891.124496988155, 3902.35611124167, 3923.7449565778134, 49033.509664903606, 49410.258846117336, 49431.50568494341, 49875.75062124739, 50424.49575504271, 46455.76772116186, 47263.0, 48287.517124829006, 48597.75701121543, 49084.26373604399, 41445.37831932523, 42082.15835683269, 42222.78888605537, 43291.35062974058, 43443.78278108653, 8217.876731848908, 8545.615447304763, 8589.871151932852, 8649.394542381973, 8951.239144672776, 31132.22169445782, 31767.523487148173, 32427.837860810545, 32471.0, 32476.0, 41175.38236926388, 41314.0, 41833.0, 41858.162836742486, 42203.57796422119, 10676.252662313564, 10732.53239807962, 10863.913608639074, 10970.616028438966, 11041.447927603427, 11677.416129193676, 11966.820497692715, 12023.879761202626, 12096.274223546616, 12108.0, 10174.949125254327, 10381.636642717469, 10382.221333399873, 10772.515236814519, 10957.50691218913, 10623.521941512496, 10930.0, 11029.22795404314, 11293.491792869176, 11321.207515473838, 11370.0, 11843.526258949545, 11859.58491452795, 12225.755484890431, 12248.265104093784, 9644.807103858024, 9734.021988044553, 9825.55784989663, 9835.803283934138, 9930.950345248517, 9203.447793132433, 9288.674896378594, 9289.581968811555, 9368.81262374735, 9477.431354118775], "unit": "score", "name": "yui.html", "value": 6123.218848354824}], "name": "dromaeo_css", "value": 6761.2437223226125}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 111.0, 111.0, 111.0, 101.0, 111.0, 110.0, 103.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [148.0, 126.0, 152.0, 169.0, 135.0, 160.0, 149.0, 128.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 163.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 97.0, 71.0, 74.0, 71.0, 110.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 150.0, 96.0, 96.0, 96.0, 143.0, 97.0, 98.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 58.0, 57.0, 59.0, 57.0, 58.0, 68.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 93.0, 85.0, 85.0, 86.0, 87.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 116.0, 121.0, 120.0, 118.0, 121.0, 116.0, 116.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 154.0, 150.0, 152.0, 142.0, 153.0, 155.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 69.0, 68.0, 67.0, 67.0, 69.0, 75.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1507.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.9261125104954], "unit": "score", "name": "Richards", "value": 210.22340999999997}, {"lowerIsBetter": false, "replicates": [191.20458891013385], "unit": "score", "name": "DeltaBlue", "value": 345.79713999999984}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12378.048780487805], "unit": "score", "name": "Boyer", "value": 53.842331034482775}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [672.4949562878278], "unit": "score", "name": "Splay", "value": 121.17711699999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19476.207495741313}]} 05:13:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19476.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6761.24"}}} 05:13:36 INFO - Return code: 0 05:13:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:13:36 INFO - # TBPL SUCCESS # 05:13:36 INFO - Running post-action listener: _resource_record_post_action 05:13:36 INFO - Running post-run listener: _resource_record_post_run 05:13:37 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 564822016; Read time: 0; Write time: 693460 05:13:37 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 248143872; Read time: 0; Write time: 459912 05:13:37 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 315813888; Read time: 0; Write time: 233512 05:13:37 INFO - Running post-run listener: _upload_blobber_files 05:13:37 INFO - Blob upload gear active. 05:13:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:13:37 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:13:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:13:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:39 INFO - (blobuploader) - INFO - Done attempting. 05:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:39 INFO - (blobuploader) - INFO - Done attempting. 05:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:39 INFO - Return code: 0 05:13:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dee45f42d753c0d2926955f672cfb9297656e43fa12388b217a48b6e767ae7105d3aa179adbeae6fdc2312621dbcc3d80499b8df0b65ec174499ad945afbd33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8652f18d0f1e5d4a8443b982121e941208799ed4f6ef01d201116d72dbbc4185c975d1493d3560632a574f5110bbef0b364d1b120417d9e142156693d938e7ca"} 05:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:13:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:13:39 INFO - Contents: 05:13:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dee45f42d753c0d2926955f672cfb9297656e43fa12388b217a48b6e767ae7105d3aa179adbeae6fdc2312621dbcc3d80499b8df0b65ec174499ad945afbd33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8652f18d0f1e5d4a8443b982121e941208799ed4f6ef01d201116d72dbbc4185c975d1493d3560632a574f5110bbef0b364d1b120417d9e142156693d938e7ca"} 05:13:39 INFO - Copying logs to upload dir... 05:13:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.671522 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-31 05:13:39.680519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 05:13:39.683901) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dee45f42d753c0d2926955f672cfb9297656e43fa12388b217a48b6e767ae7105d3aa179adbeae6fdc2312621dbcc3d80499b8df0b65ec174499ad945afbd33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8652f18d0f1e5d4a8443b982121e941208799ed4f6ef01d201116d72dbbc4185c975d1493d3560632a574f5110bbef0b364d1b120417d9e142156693d938e7ca"} build_url:https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/M5mJbhNWTya4klyv4kvgIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dee45f42d753c0d2926955f672cfb9297656e43fa12388b217a48b6e767ae7105d3aa179adbeae6fdc2312621dbcc3d80499b8df0b65ec174499ad945afbd33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8652f18d0f1e5d4a8443b982121e941208799ed4f6ef01d201116d72dbbc4185c975d1493d3560632a574f5110bbef0b364d1b120417d9e142156693d938e7ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 05:13:39.708795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 05:13:39.709125) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451562615.513195-907506944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 05:13:39.791478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 05:13:39.791874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 05:13:39.792213) ========= ========= Total master_lag: 0.24 =========