builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1450532257.58 results: success (0) buildid: 20151219030215 builduid: e93ed16aadb94eb1a05a4c2c3ce37304 revision: c5cb194cc9cb56d742fb3a7a826f0080b0404edc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.582323) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.582824) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.583126) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006233 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.612647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.612924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.678215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.678469) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.744411) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.744682) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.745025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.745295) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-19 05:37:37-- 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% 225M=0s 2015-12-19 05:37:38 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.950931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:37.951238) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014347 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.000650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.001020) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-19 05:37:38,115 truncating revision to first 12 chars 2015-12-19 05:37:38,115 Setting DEBUG logging. 2015-12-19 05:37:38,115 attempt 1/10 2015-12-19 05:37:38,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5cb194cc9cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-19 05:37:38,595 unpacking tar archive at: mozilla-central-c5cb194cc9cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.781778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.782173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.792048) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.792415) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 05:37:38.792912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-19 05:37:38.793223) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:38 INFO - MultiFileLogger online at 20151219 05:37:38 in /builds/slave/test-pgo 05:37:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:37:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:37:38 INFO - {'append_to_log': False, 05:37:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:37:38 INFO - 'blob_upload_branch': 'Firefox', 05:37:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:37:38 INFO - 'branch': 'Firefox', 05:37:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:38 INFO - 'config_files': ('talos/linux_config.py',), 05:37:38 INFO - 'default_actions': ('clobber', 05:37:38 INFO - 'read-buildbot-config', 05:37:38 INFO - 'download-and-extract', 05:37:38 INFO - 'populate-webroot', 05:37:38 INFO - 'create-virtualenv', 05:37:38 INFO - 'install', 05:37:38 INFO - 'run-tests'), 05:37:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:38 INFO - 'download_minidump_stackwalk': True, 05:37:38 INFO - 'download_symbols': 'ondemand', 05:37:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:38 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:38 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:38 INFO - 'installer_path': 'installer.exe', 05:37:38 INFO - 'log_level': 'info', 05:37:38 INFO - 'log_name': 'talos', 05:37:38 INFO - 'log_to_console': True, 05:37:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:38 INFO - 'opt_config_files': (), 05:37:38 INFO - 'pip_index': False, 05:37:38 INFO - 'sps_profile': False, 05:37:38 INFO - 'sps_profile_interval': 0, 05:37:38 INFO - 'suite': 'dromaeojs', 05:37:38 INFO - 'system_bits': '64', 05:37:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:38 INFO - 'title': 'talos-linux64-ix-009', 05:37:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:38 INFO - 'use_talos_json': True, 05:37:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:37:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:38 INFO - 'work_dir': 'build'} 05:37:38 INFO - ##### 05:37:38 INFO - ##### Running clobber step. 05:37:38 INFO - ##### 05:37:38 INFO - Running pre-action listener: _resource_record_pre_action 05:37:38 INFO - Running main action method: clobber 05:37:38 INFO - rmtree: /builds/slave/test-pgo/build 05:37:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:37:39 INFO - Running post-action listener: _resource_record_post_action 05:37:39 INFO - ##### 05:37:39 INFO - ##### Running read-buildbot-config step. 05:37:39 INFO - ##### 05:37:39 INFO - Running pre-action listener: _resource_record_pre_action 05:37:39 INFO - Running main action method: read_buildbot_config 05:37:39 INFO - Using buildbot properties: 05:37:39 INFO - { 05:37:39 INFO - "project": "", 05:37:39 INFO - "product": "firefox", 05:37:39 INFO - "script_repo_revision": "production", 05:37:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:37:39 INFO - "repository": "", 05:37:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:37:39 INFO - "buildid": "20151219030215", 05:37:39 INFO - "stage_platform": "linux64-pgo", 05:37:39 INFO - "basedir": "/builds/slave/test-pgo", 05:37:39 INFO - "nightly_build": "True", 05:37:39 INFO - "buildnumber": 608, 05:37:39 INFO - "slavename": "talos-linux64-ix-009", 05:37:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:37:39 INFO - "platform": "ubuntu64_hw", 05:37:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:37:39 INFO - "branch": "mozilla-central", 05:37:39 INFO - "repo_path": "mozilla-central", 05:37:39 INFO - "revision": "c5cb194cc9cb56d742fb3a7a826f0080b0404edc", 05:37:39 INFO - "pgo_build": "True", 05:37:39 INFO - "builduid": "e93ed16aadb94eb1a05a4c2c3ce37304", 05:37:39 INFO - "slavebuilddir": "test" 05:37:39 INFO - } 05:37:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:37:39 INFO - Running post-action listener: _resource_record_post_action 05:37:39 INFO - ##### 05:37:39 INFO - ##### Running download-and-extract step. 05:37:39 INFO - ##### 05:37:39 INFO - Running pre-action listener: _resource_record_pre_action 05:37:39 INFO - Running main action method: download_and_extract 05:37:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:39 INFO - https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/test_packages.json 05:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/test_packages.json 05:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:37:44 INFO - Downloaded 1302 bytes. 05:37:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:37:44 INFO - Using the following test package requirements: 05:37:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'jsshell-linux-x86_64.zip'], 05:37:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:44 INFO - https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:48 INFO - Downloaded 23120969 bytes. 05:37:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:49 INFO - Return code: 0 05:37:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:49 INFO - https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:53 INFO - Downloaded 23120969 bytes. 05:37:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:37:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:37:54 INFO - Return code: 0 05:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:54 INFO - https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:37:55 INFO - Downloaded 11132039 bytes. 05:37:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:37:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:37:55 INFO - Return code: 0 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:37:56 INFO - Downloaded 54646849 bytes. 05:37:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:56 INFO - mkdir: /builds/slave/test-pgo/properties 05:37:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:37:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:37:56 INFO - Contents: 05:37:56 INFO - build_url:https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:37:56 INFO - Running post-action listener: _resource_record_post_action 05:37:56 INFO - Running post-action listener: set_extra_try_arguments 05:37:56 INFO - ##### 05:37:56 INFO - ##### Running populate-webroot step. 05:37:56 INFO - ##### 05:37:56 INFO - Running pre-action listener: _resource_record_pre_action 05:37:56 INFO - Running main action method: populate_webroot 05:37:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:56 INFO - '--tppagecycles', 05:37:56 INFO - '7'], 05:37:56 INFO - 'tests': ['tsvgm']}}, 05:37:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:37:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'tests': ['damp', 'tps']}, 05:37:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['damp', 'tps']}, 05:37:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:56 INFO - 'other': {'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'other_l64': {'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:56 INFO - 'ts_paint', 05:37:56 INFO - 'tpaint', 05:37:56 INFO - 'sessionrestore', 05:37:56 INFO - 'sessionrestore_no_auto_restore']}, 05:37:56 INFO - 'svgr': {'tests': ['tsvgx', 05:37:56 INFO - 'tsvgr_opacity', 05:37:56 INFO - 'tart', 05:37:56 INFO - 'tscrollx', 05:37:56 INFO - 'cart']}, 05:37:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['tsvgx', 05:37:56 INFO - 'tsvgr_opacity', 05:37:56 INFO - 'tart', 05:37:56 INFO - 'tscrollx', 05:37:56 INFO - 'cart']}, 05:37:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'tests': ['tp5o']}, 05:37:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'talos_options': ['--e10s'], 05:37:56 INFO - 'tests': ['tp5o']}, 05:37:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'talos_options': ['--xperf_path', 05:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:56 INFO - 'tests': ['tp5n']}, 05:37:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:56 INFO - 'talos_options': ['--e10s', 05:37:56 INFO - '--xperf_path', 05:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:56 INFO - 'tests': ['tp5n']}}, 05:37:56 INFO - 'talos.zip': {'path': '', 05:37:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:56 INFO - Running post-action listener: _resource_record_post_action 05:37:56 INFO - ##### 05:37:56 INFO - ##### Running create-virtualenv step. 05:37:56 INFO - ##### 05:37:56 INFO - Running pre-action listener: _resource_record_pre_action 05:37:56 INFO - Running main action method: create_virtualenv 05:37:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:37:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:37:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:37:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:56 INFO - Using real prefix '/usr' 05:37:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:37:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:59 INFO - Installing pip.................done. 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:37:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:59 INFO - Using env: {'DISPLAY': ':0', 05:37:59 INFO - 'HOME': '/home/cltbld', 05:37:59 INFO - 'LANG': 'en_US.UTF-8', 05:37:59 INFO - 'LANGUAGE': 'en_US:en', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MAIL': '/var/mail/cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SHLVL': '1', 05:37:59 INFO - 'TERM': 'linux', 05:37:59 INFO - 'TMOUT': '86400', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - '_': '/tools/buildbot/bin/python'} 05:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:37:59 INFO - Cleaning up... 05:37:59 INFO - Return code: 0 05:37:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:59 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:37:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:37:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:37:59 INFO - Using env: {'DISPLAY': ':0', 05:37:59 INFO - 'HOME': '/home/cltbld', 05:37:59 INFO - 'LANG': 'en_US.UTF-8', 05:37:59 INFO - 'LANGUAGE': 'en_US:en', 05:37:59 INFO - 'LOGNAME': 'cltbld', 05:37:59 INFO - 'MAIL': '/var/mail/cltbld', 05:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:59 INFO - 'MOZ_NO_REMOTE': '1', 05:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:59 INFO - 'NO_EM_RESTART': '1', 05:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:37:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:37:59 INFO - 'SHELL': '/bin/bash', 05:37:59 INFO - 'SHLVL': '1', 05:37:59 INFO - 'TERM': 'linux', 05:37:59 INFO - 'TMOUT': '86400', 05:37:59 INFO - 'USER': 'cltbld', 05:37:59 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:59 INFO - '_': '/tools/buildbot/bin/python'} 05:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:59 INFO - Downloading/unpacking psutil>=0.7.1 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:38:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:38:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:01 INFO - Installing collected packages: psutil 05:38:01 INFO - Running setup.py install for psutil 05:38:01 INFO - building 'psutil._psutil_linux' extension 05:38:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:38:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:38:01 INFO - building 'psutil._psutil_posix' extension 05:38:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:38:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:02 INFO - Successfully installed psutil 05:38:02 INFO - Cleaning up... 05:38:02 INFO - Return code: 0 05:38:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:02 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:38:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:38:02 INFO - Using env: {'DISPLAY': ':0', 05:38:02 INFO - 'HOME': '/home/cltbld', 05:38:02 INFO - 'LANG': 'en_US.UTF-8', 05:38:02 INFO - 'LANGUAGE': 'en_US:en', 05:38:02 INFO - 'LOGNAME': 'cltbld', 05:38:02 INFO - 'MAIL': '/var/mail/cltbld', 05:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:02 INFO - 'MOZ_NO_REMOTE': '1', 05:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:02 INFO - 'NO_EM_RESTART': '1', 05:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:02 INFO - 'SHELL': '/bin/bash', 05:38:02 INFO - 'SHLVL': '1', 05:38:02 INFO - 'TERM': 'linux', 05:38:02 INFO - 'TMOUT': '86400', 05:38:02 INFO - 'USER': 'cltbld', 05:38:02 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:02 INFO - '_': '/tools/buildbot/bin/python'} 05:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:38:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:38:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:38:04 INFO - Installing collected packages: mozsystemmonitor 05:38:04 INFO - Running setup.py install for mozsystemmonitor 05:38:04 INFO - Successfully installed mozsystemmonitor 05:38:04 INFO - Cleaning up... 05:38:04 INFO - Return code: 0 05:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:04 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:38:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:38:04 INFO - Using env: {'DISPLAY': ':0', 05:38:04 INFO - 'HOME': '/home/cltbld', 05:38:04 INFO - 'LANG': 'en_US.UTF-8', 05:38:04 INFO - 'LANGUAGE': 'en_US:en', 05:38:04 INFO - 'LOGNAME': 'cltbld', 05:38:04 INFO - 'MAIL': '/var/mail/cltbld', 05:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:04 INFO - 'MOZ_NO_REMOTE': '1', 05:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:04 INFO - 'NO_EM_RESTART': '1', 05:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:04 INFO - 'SHELL': '/bin/bash', 05:38:04 INFO - 'SHLVL': '1', 05:38:04 INFO - 'TERM': 'linux', 05:38:04 INFO - 'TMOUT': '86400', 05:38:04 INFO - 'USER': 'cltbld', 05:38:04 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:04 INFO - '_': '/tools/buildbot/bin/python'} 05:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:38:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:06 INFO - Downloading docopt-0.6.1.tar.gz 05:38:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:38:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:06 INFO - Running setup.py install for blobuploader 05:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:38:07 INFO - Running setup.py install for requests 05:38:07 INFO - Running setup.py install for docopt 05:38:07 INFO - Successfully installed blobuploader requests docopt 05:38:07 INFO - Cleaning up... 05:38:07 INFO - Return code: 0 05:38:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:07 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:38:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:07 INFO - Using env: {'DISPLAY': ':0', 05:38:07 INFO - 'HOME': '/home/cltbld', 05:38:07 INFO - 'LANG': 'en_US.UTF-8', 05:38:07 INFO - 'LANGUAGE': 'en_US:en', 05:38:07 INFO - 'LOGNAME': 'cltbld', 05:38:07 INFO - 'MAIL': '/var/mail/cltbld', 05:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:07 INFO - 'MOZ_NO_REMOTE': '1', 05:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:07 INFO - 'NO_EM_RESTART': '1', 05:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:07 INFO - 'SHELL': '/bin/bash', 05:38:07 INFO - 'SHLVL': '1', 05:38:07 INFO - 'TERM': 'linux', 05:38:07 INFO - 'TMOUT': '86400', 05:38:07 INFO - 'USER': 'cltbld', 05:38:07 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:07 INFO - '_': '/tools/buildbot/bin/python'} 05:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:38:07 INFO - Running setup.py (path:/tmp/pip-zs1jaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:38:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:38:07 INFO - Running setup.py (path:/tmp/pip-XnMhfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:38:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:38:07 INFO - Running setup.py (path:/tmp/pip-T7OEwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:38:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:38:07 INFO - Running setup.py (path:/tmp/pip-LFCx48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:38:08 INFO - Running setup.py (path:/tmp/pip-Kw5TlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:38:08 INFO - Running setup.py (path:/tmp/pip-C5JZ7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:38:08 INFO - Running setup.py (path:/tmp/pip-4nwNxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:38:08 INFO - Running setup.py (path:/tmp/pip-9RQysA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:38:08 INFO - Running setup.py (path:/tmp/pip-T0RueG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:38:08 INFO - Running setup.py (path:/tmp/pip-1Z0hK8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:38:08 INFO - Running setup.py (path:/tmp/pip-wenyzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:38:08 INFO - Running setup.py (path:/tmp/pip-vy85nO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:38:08 INFO - Running setup.py (path:/tmp/pip-SaZpBS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:38:08 INFO - Running setup.py (path:/tmp/pip-9cmU3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Running setup.py (path:/tmp/pip-7S9WVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:38:08 INFO - Running setup.py (path:/tmp/pip-SoqyRx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:38:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:38:08 INFO - Running setup.py (path:/tmp/pip-0VFugx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:08 INFO - Running setup.py install for manifestparser 05:38:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for mozcrash 05:38:09 INFO - Running setup.py install for mozdebug 05:38:09 INFO - Running setup.py install for mozdevice 05:38:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for mozfile 05:38:09 INFO - Running setup.py install for mozhttpd 05:38:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for mozinfo 05:38:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for mozInstall 05:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for mozleak 05:38:09 INFO - Running setup.py install for mozlog 05:38:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:38:09 INFO - Running setup.py install for moznetwork 05:38:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Running setup.py install for mozprocess 05:38:10 INFO - Running setup.py install for mozprofile 05:38:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Running setup.py install for mozrunner 05:38:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Running setup.py install for mozscreenshot 05:38:10 INFO - Running setup.py install for moztest 05:38:10 INFO - Running setup.py install for mozversion 05:38:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:10 INFO - Cleaning up... 05:38:10 INFO - Return code: 0 05:38:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:10 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:38:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:10 INFO - Using env: {'DISPLAY': ':0', 05:38:10 INFO - 'HOME': '/home/cltbld', 05:38:10 INFO - 'LANG': 'en_US.UTF-8', 05:38:10 INFO - 'LANGUAGE': 'en_US:en', 05:38:10 INFO - 'LOGNAME': 'cltbld', 05:38:10 INFO - 'MAIL': '/var/mail/cltbld', 05:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:10 INFO - 'MOZ_NO_REMOTE': '1', 05:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:10 INFO - 'NO_EM_RESTART': '1', 05:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:10 INFO - 'SHELL': '/bin/bash', 05:38:10 INFO - 'SHLVL': '1', 05:38:10 INFO - 'TERM': 'linux', 05:38:10 INFO - 'TMOUT': '86400', 05:38:10 INFO - 'USER': 'cltbld', 05:38:10 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:10 INFO - '_': '/tools/buildbot/bin/python'} 05:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:38:10 INFO - Running setup.py (path:/tmp/pip-Jtwfjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:38:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:38:11 INFO - Running setup.py (path:/tmp/pip-gxttbw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:38:11 INFO - Running setup.py (path:/tmp/pip-KlJisP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:38:11 INFO - Running setup.py (path:/tmp/pip-u_E1nI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:38:11 INFO - Running setup.py (path:/tmp/pip-c2KHIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:38:11 INFO - Running setup.py (path:/tmp/pip-aSZ2mi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:38:11 INFO - Running setup.py (path:/tmp/pip-U4NfAA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:38:11 INFO - Running setup.py (path:/tmp/pip-2rNoKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:38:11 INFO - Running setup.py (path:/tmp/pip-MdXyym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:38:11 INFO - Running setup.py (path:/tmp/pip-f0BA02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:38:11 INFO - Running setup.py (path:/tmp/pip-2J4RFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:38:11 INFO - Running setup.py (path:/tmp/pip-49TM57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:38:11 INFO - Running setup.py (path:/tmp/pip-CrJ3Wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:38:11 INFO - Running setup.py (path:/tmp/pip-SYtnwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:38:11 INFO - Running setup.py (path:/tmp/pip-XdDDDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:38:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:38:12 INFO - Running setup.py (path:/tmp/pip-IMpKhc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:38:12 INFO - Running setup.py (path:/tmp/pip-uOhcJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - Downloading blessings-1.5.1.tar.gz 05:38:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:38:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:13 INFO - Installing collected packages: blessings 05:38:13 INFO - Running setup.py install for blessings 05:38:14 INFO - Successfully installed blessings 05:38:14 INFO - Cleaning up... 05:38:14 INFO - Return code: 0 05:38:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:38:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:38:14 INFO - Reading from file tmpfile_stdout 05:38:14 INFO - Current package versions: 05:38:14 INFO - argparse == 1.2.1 05:38:14 INFO - blessings == 1.5.1 05:38:14 INFO - blobuploader == 1.2.4 05:38:14 INFO - docopt == 0.6.1 05:38:14 INFO - manifestparser == 1.1 05:38:14 INFO - mozInstall == 1.12 05:38:14 INFO - mozcrash == 0.16 05:38:14 INFO - mozdebug == 0.1 05:38:14 INFO - mozdevice == 0.47 05:38:14 INFO - mozfile == 1.2 05:38:14 INFO - mozhttpd == 0.7 05:38:14 INFO - mozinfo == 0.9 05:38:14 INFO - mozleak == 0.1 05:38:14 INFO - mozlog == 3.1 05:38:14 INFO - moznetwork == 0.27 05:38:14 INFO - mozprocess == 0.22 05:38:14 INFO - mozprofile == 0.27 05:38:14 INFO - mozrunner == 6.11 05:38:14 INFO - mozscreenshot == 0.1 05:38:14 INFO - mozsystemmonitor == 0.0 05:38:14 INFO - moztest == 0.7 05:38:14 INFO - mozversion == 1.4 05:38:14 INFO - psutil == 3.1.1 05:38:14 INFO - requests == 1.2.3 05:38:14 INFO - wsgiref == 0.1.2 05:38:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:14 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:38:14 INFO - Using env: {'DISPLAY': ':0', 05:38:14 INFO - 'HOME': '/home/cltbld', 05:38:14 INFO - 'LANG': 'en_US.UTF-8', 05:38:14 INFO - 'LANGUAGE': 'en_US:en', 05:38:14 INFO - 'LOGNAME': 'cltbld', 05:38:14 INFO - 'MAIL': '/var/mail/cltbld', 05:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:14 INFO - 'MOZ_NO_REMOTE': '1', 05:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:14 INFO - 'NO_EM_RESTART': '1', 05:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:14 INFO - 'SHELL': '/bin/bash', 05:38:14 INFO - 'SHLVL': '1', 05:38:14 INFO - 'TERM': 'linux', 05:38:14 INFO - 'TMOUT': '86400', 05:38:14 INFO - 'USER': 'cltbld', 05:38:14 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:14 INFO - '_': '/tools/buildbot/bin/python'} 05:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:14 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 1)) 05:38:14 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 2)) 05:38:14 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 3)) 05:38:14 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 4)) 05:38:14 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 5)) 05:38:14 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 6)) 05:38:14 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 7)) 05:38:14 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 8)) 05:38:14 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:38:14 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 3)) 05:38:14 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:38:14 INFO - Cleaning up... 05:38:14 INFO - Return code: 0 05:38:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:14 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:38:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:38:14 INFO - Using env: {'DISPLAY': ':0', 05:38:14 INFO - 'HOME': '/home/cltbld', 05:38:14 INFO - 'LANG': 'en_US.UTF-8', 05:38:14 INFO - 'LANGUAGE': 'en_US:en', 05:38:14 INFO - 'LOGNAME': 'cltbld', 05:38:14 INFO - 'MAIL': '/var/mail/cltbld', 05:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:14 INFO - 'MOZ_NO_REMOTE': '1', 05:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:14 INFO - 'NO_EM_RESTART': '1', 05:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:14 INFO - 'SHELL': '/bin/bash', 05:38:14 INFO - 'SHLVL': '1', 05:38:14 INFO - 'TERM': 'linux', 05:38:14 INFO - 'TMOUT': '86400', 05:38:14 INFO - 'USER': 'cltbld', 05:38:14 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:14 INFO - '_': '/tools/buildbot/bin/python'} 05:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:14 INFO - Downloading/unpacking jsonschema 05:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:38:16 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:38:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:16 INFO - warning: no files found matching '*.txt' 05:38:16 INFO - no previously-included directories found matching 'build' 05:38:16 INFO - no previously-included directories found matching 'dist' 05:38:16 INFO - no previously-included directories found matching '.git*' 05:38:16 INFO - Installing collected packages: jsonschema, functools32 05:38:16 INFO - Running setup.py install for functools32 05:38:16 INFO - warning: no files found matching '*.txt' 05:38:16 INFO - no previously-included directories found matching 'build' 05:38:16 INFO - no previously-included directories found matching 'dist' 05:38:16 INFO - no previously-included directories found matching '.git*' 05:38:16 INFO - Successfully installed jsonschema functools32 05:38:16 INFO - Cleaning up... 05:38:16 INFO - Return code: 0 05:38:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:16 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 0x7f51da6f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:38:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:38:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:38:16 INFO - Using env: {'DISPLAY': ':0', 05:38:16 INFO - 'HOME': '/home/cltbld', 05:38:16 INFO - 'LANG': 'en_US.UTF-8', 05:38:16 INFO - 'LANGUAGE': 'en_US:en', 05:38:16 INFO - 'LOGNAME': 'cltbld', 05:38:16 INFO - 'MAIL': '/var/mail/cltbld', 05:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:16 INFO - 'MOZ_NO_REMOTE': '1', 05:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:16 INFO - 'NO_EM_RESTART': '1', 05:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:16 INFO - 'SHELL': '/bin/bash', 05:38:16 INFO - 'SHLVL': '1', 05:38:16 INFO - 'TERM': 'linux', 05:38:16 INFO - 'TMOUT': '86400', 05:38:16 INFO - 'USER': 'cltbld', 05:38:16 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:16 INFO - '_': '/tools/buildbot/bin/python'} 05:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:17 INFO - Downloading/unpacking flake8 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:38:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:38:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:38:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:38:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:19 INFO - no previously-included directories found matching 'docs/_build' 05:38:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:19 INFO - Running setup.py install for pep8 05:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:19 INFO - no previously-included directories found matching 'docs/_build' 05:38:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:38:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:19 INFO - Cleaning up... 05:38:19 INFO - Return code: 0 05:38:19 INFO - Running post-action listener: _resource_record_post_action 05:38:19 INFO - Running post-action listener: _start_resource_monitoring 05:38:19 INFO - Starting resource monitoring. 05:38:19 INFO - ##### 05:38:19 INFO - ##### Running install step. 05:38:19 INFO - ##### 05:38:19 INFO - Running pre-action listener: _resource_record_pre_action 05:38:19 INFO - Running main action method: install 05:38:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:38:19 INFO - Reading from file tmpfile_stdout 05:38:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:38:19 INFO - Reading from file tmpfile_stdout 05:38:19 INFO - Output received: 05:38:19 INFO - Usage: mozinstall [options] installer 05:38:19 INFO - Options: 05:38:19 INFO - -h, --help show this help message and exit 05:38:19 INFO - -d DEST, --destination=DEST 05:38:19 INFO - Directory to install application into. [default: 05:38:19 INFO - "/builds/slave/test-pgo"] 05:38:19 INFO - --app=APP Application being installed. [default: firefox] 05:38:19 INFO - mkdir: /builds/slave/test-pgo/build/application 05:38:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:38:35 INFO - Reading from file tmpfile_stdout 05:38:35 INFO - Output received: 05:38:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:38:35 INFO - Running post-action listener: _resource_record_post_action 05:38:35 INFO - ##### 05:38:35 INFO - ##### Running run-tests step. 05:38:35 INFO - ##### 05:38:35 INFO - Running pre-action listener: _resource_record_pre_action 05:38:35 INFO - Running main action method: run_tests 05:38:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:38:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:38:35 INFO - Python 2.7.3 05:38:35 INFO - Return code: 0 05:38:35 INFO - grabbing minidump binary from tooltool 05:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:35 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 0x1954350>, '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 0x1955250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19556e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:38:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:38:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:38:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:35 INFO - Return code: 0 05:38:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:38:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:38:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:38:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:38:36 INFO - Return code: 0 05:38:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:38:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 05:38:36 INFO - Using env: {'DISPLAY': ':0', 05:38:36 INFO - 'HOME': '/home/cltbld', 05:38:36 INFO - 'LANG': 'en_US.UTF-8', 05:38:36 INFO - 'LANGUAGE': 'en_US:en', 05:38:36 INFO - 'LOGNAME': 'cltbld', 05:38:36 INFO - 'MAIL': '/var/mail/cltbld', 05:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:36 INFO - 'MOZ_NO_REMOTE': '1', 05:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:36 INFO - 'NO_EM_RESTART': '1', 05:38:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:38:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:38:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:38:36 INFO - 'SHELL': '/bin/bash', 05:38:36 INFO - 'SHLVL': '1', 05:38:36 INFO - 'TERM': 'linux', 05:38:36 INFO - 'TMOUT': '86400', 05:38:36 INFO - 'USER': 'cltbld', 05:38:36 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917', 05:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:36 INFO - '_': '/tools/buildbot/bin/python'} 05:38:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 05:38:36 INFO - mozversion INFO | application_buildid: 20151219030215 05:38:36 INFO - mozversion INFO | application_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 05:38:36 INFO - mozversion INFO | application_display_name: Nightly 05:38:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:36 INFO - mozversion INFO | application_name: Firefox 05:38:36 INFO - mozversion INFO | application_remotingname: firefox 05:38:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:38:36 INFO - mozversion INFO | application_vendor: Mozilla 05:38:36 INFO - mozversion INFO | application_version: 46.0a1 05:38:36 INFO - mozversion INFO | platform_buildid: 20151219030215 05:38:36 INFO - mozversion INFO | platform_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 05:38:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:38:36 INFO - mozversion INFO | platform_version: 46.0a1 05:38:36 INFO - 2015-12-19 05:38:36,991 DEBUG : using testdate: 1450532316 05:38:36 INFO - 2015-12-19 05:38:36,991 DEBUG : actual date: 1450532316 05:38:37 INFO - 2015-12-19 05:38:36,999 INFO : starting webserver on 'localhost:52590' 05:38:37 INFO - 2015-12-19 05:38:37,000 INFO : Starting test suite talos-linux64-ix-009 05:38:37 INFO - 2015-12-19 05:38:37,000 INFO : Starting test dromaeo_css 05:38:37 INFO - 2015-12-19 05:38:37,001 DEBUG : operating with platform_type : linux_ 05:38:37 INFO - 2015-12-19 05:38:37,001 INFO : Initialising browser for dromaeo_css test... 05:38:37 INFO - 2015-12-19 05:38:37,015 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwfbSZ5/profile http://localhost:52590/getInfo.html 05:38:41 INFO - 2015-12-19 05:38:41,565 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:38:41 INFO - 2015-12-19 05:38:41,565 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:38:41 INFO - 2015-12-19 05:38:41,566 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:38:41 INFO - 2015-12-19 05:38:41,566 DEBUG : BROWSER_OUTPUT: __metrics 05:38:41 INFO - 2015-12-19 05:38:41,629 DEBUG : BROWSER_OUTPUT: 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:38:41 INFO - 2015-12-19 05:38:41,685 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:41 ERROR - 2015-12-19 05:38:41,693 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:38:42 INFO - 2015-12-19 05:38:42,534 INFO : Browser initialized. 05:38:42 INFO - 2015-12-19 05:38:42,535 INFO : Running cycle 1/1 for dromaeo_css test... 05:38:42 INFO - 2015-12-19 05:38:42,535 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwfbSZ5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:54 INFO - 2015-12-19 05:38:54,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 149753856 05:38:54 INFO - 2015-12-19 05:38:54,267 DEBUG : BROWSER_OUTPUT: 05:39:45 INFO - 2015-12-19 05:39:45,695 DEBUG : BROWSER_OUTPUT: 1450532385687 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:41:54 INFO - 2015-12-19 05:41:54,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52590/tests/dromaeo/cssquery-ext.html) 05:41:55 INFO - 2015-12-19 05:41:55,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 259088384 05:41:55 INFO - 2015-12-19 05:41:55,442 DEBUG : BROWSER_OUTPUT: 05:44:57 INFO - 2015-12-19 05:44:57,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-ext.html (next: http://localhost:52590/tests/dromaeo/cssquery-jquery.html) 05:44:58 INFO - 2015-12-19 05:44:58,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 238616576 05:44:58 INFO - 2015-12-19 05:44:58,454 DEBUG : BROWSER_OUTPUT: 05:48:00 INFO - 2015-12-19 05:48:00,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52590/tests/dromaeo/cssquery-mootools.html) 05:48:00 INFO - 2015-12-19 05:48:00,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 228032512 05:48:00 INFO - 2015-12-19 05:48:00,882 DEBUG : BROWSER_OUTPUT: 05:51:02 INFO - 2015-12-19 05:51:02,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52590/tests/dromaeo/cssquery-prototype.html) 05:51:03 INFO - 2015-12-19 05:51:03,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 212774912 05:51:03 INFO - 2015-12-19 05:51:03,244 DEBUG : BROWSER_OUTPUT: 05:54:05 INFO - 2015-12-19 05:54:05,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52590/tests/dromaeo/cssquery-yui.html) 05:54:06 INFO - 2015-12-19 05:54:06,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 217247744 05:54:06 INFO - 2015-12-19 05:54:06,213 DEBUG : BROWSER_OUTPUT: 05:57:08 INFO - 2015-12-19 05:57:08,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/dromaeo/cssquery-yui.html (next: http://localhost:52590/tests/dromaeo/cssquery-dojo.html) 05:57:09 INFO - 2015-12-19 05:57:09,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 242806784 05:57:09 INFO - 2015-12-19 05:57:09,035 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:57:09 INFO - 2015-12-19 05:57:09,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:57:09 INFO - 2015-12-19 05:57:09,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:57:09 INFO - 2015-12-19 05:57:09,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:57:09 INFO - 2015-12-19 05:57:09,040 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3020.818750874947;3039.4984827503463;3085.5217441296595;3087.9809662811276;3111.0200286909617;5037.672551284164;5054.241863720444;5110.182370820669;5176.378834539851;5199.22011698245;5185.092608793465;5236.397814251362;5293.206019097137;5298.4701529847;5309.362876454821;4709.105269998707;4766.261229509414;4774.665773395864;4788.377510923592;4835.540623640749;4752.809887604509;4818.566329030386;4859.198232291667;4870.561649451549;4916;4544.159330523864;4643.628509719214;4811.109944660249;4820.686655367407;4857.635677324197;4579.3131030345385;4697.530246975275;4726.810927562893;4734.976325118387;4749.7387643679585;4690.4605970313505;4692.991006933526;4694.812207511695;4723.362346083303;4749;4952.4057113146655;5017.122003649347;5021.899562008776;5023.447420783711;5038.672486288379;5556.277683901067;5592.440755924375;5610.775568977236;5622.746976386073;5662.886742265173;5711.657300561979;5722.256106706143;5724.484796368305;5725.255716756837;5731.312242530923;5190.377154741455;5300.814471493556;5306.92039619406;5350.625456218067;5353.812616558402;5671.602987790898;5798.391168927286;5805.854853628609;5834.708264586754;5843.620164689281;5457.2359869618285;5464;5467.507924286833;5469.288992430958;5546.029444847136;5499.670019798825;5580.525655319343;5598.1602759586385;5599.776008959678;5620.016497112989;5493.7802487900035;5551.639143455663;5568.9443105568425;5614.803481878114;5634.577406694514;5660.688662123541;5674.432556744375;5678.261825962681;5685.914711279334;5686.061799803069;4282.957170428318;4382.561743825656;4385.122975404932;4391.473023237232;4433.733975961452;3856.5757766645647;3921.941170882439;3933;3957.149212919236;3965.464662270614;5264.210368444687;5357.464253574612;5375.139977603565;5381.865453363619;5382.2464854920345;5534.446555344433;5632.802851900164;5740.13897915316;5761.452661997104;5761.884762304814;5211.478852114834;5234.528892399702;5236.266922630834;5280.9207861882105;5292.5501332387175;4861.440934292531;4874.488178741252;4875.049365373789;4878.121938051185;4924.975375123173;5576.330840299109;5638.407967163471;5649.802256920988;5651.378348381675;5746.913796292975;5502.972485137709;5600.915986260291;5604.047311956896;5604.159376093618;5644;5808.854778630568;5849.3858144894175;5855.268091488564;5857.121431785266;5857.26784151981;5388.703621300866;5496.1755736639825;5697.4872261495;5702.201691763239;5715.142728590578;5481.095619222943;5589.161625756169;5599.04816181242;5648.887022259614;5665.773369065191;5487.807926722546;5522.558195344443;5535.3634332050715;5536.363318218457;5556.833295001156;5315.282436870973;5349;5564.805231817029;5567.805126820542;5616.719164041863;5261.763220655156;5322.760475778677;5323.920141197963;5329.333833270841;5348.465153484621;5398.676079435247;5424.918626220689;5429.972850135724;5475.534579560782;5507.366652834975;5142.51146141116;5247.868803279948;5253.894922101613;5314.97342513285;5332.33345831771 05:57:09 INFO - 2015-12-19 05:57:09,041 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.1072632057151;583.1253120319519;585.6105689716339;595.1667665268626;625.9655718935456;30841.69158308416;37369.81315093424;38507.229855402875;38541;38552.22895542088;42358.788206058925;42571.14857702844;42572.57427425725;42902.78548607261;43334.566654333445;7516.962415187916;7627.580483073429;8625.95687021564;8812.823743525125;8813.779655508599;10383.169346452303;10642.574297028148;10643.467826608678;10646.307989980665;10650.147988160967;10232.641857534987;10287.331323463988;10316.277860549764;10371.429571373572;10425.218108641844;7821.217878212218;7993.4004949628425;10286.177105831515;10589.735256618646;10855.45722713869;10251.84622230667;10376.688699338956;10389.480525973671;10392.53233604482;10395.480225988671;40682;41061;41154.79422602898;41158.79420602908;41184.38223426651;3220.6296275928335;3278.0329802708256;3361.4285571452665;3470.3753324401596;3720.293144302601;29373.001115656378;30054.84972575145;30366.240843978856;31080.067597972098;31190.376192476022;3549.112721819545;3580.2660454606744;3592.6766591006935;3664.3404187246283;3702.129999450127;280952;286031;286741;289817;289928;54014.72992635012;55027.724861376235;56010;56945.43054569484;56966;65535.118812524954;66389.66805165944;66432.6678366605;66469;66684.66549674256;13327.533536326377;13552.254625995665;13565.660858478617;13574.59276221715;13583.252921089237;10024.448655323882;10067.69796906094;10095.646652367132;10101.494925253708;10154.847677284699;18270.360537381395;18414.26342946294;18649.440516784518;18758.906205468884;18792.812071879107;7392.260773922565;7442.18136005039;7446.515976461513;7612.543247405173;7668.271514206142;918.5040078357612;987.8468837330225;997;1047.994760026195;1137.766757814646;27470.862645687044;28386.43227135487;28509.429811403657;28725;28848.567271490945;942.641796117471;1035.3529044347283;1091.0562363555625;1102.9117670586495;1107.9058280046124;14485.637859053397;14713.779293310608;14818.481353152589;15095.773563396559;15117.16855572932;340840;341605;345109;345174;345213;50736.238956415684;51543.226851597254;51741;51894.22158667623;51953.96092078213;1138.6014894786924;1330.381372661717;1335.9265240411871;1350.9459621615222;1351.49319005373;27385.726142739113;28254.434911301247;28334.79683882803;28425;28757.28106797347;45607;46299.305510418046;46329;46475.53524464712;46514;313184;313840;314499;314501;315187;27361.31596710098;30878.53682194724;31345.686543134278;31468.842655786575;31744.8412757944;38008;40218.39672404858;40572;41304.1739165221;41470;34352.312953740286;34882.30235395227;34943.65056349404;35114.297714046086;35976.460353095244;29124.232217158038;31480.37039259248;33548.25260211112;34669.13327166841;35076.82461587676;31426;31937.520937185494;31977.68022319747;32119;32616.184595385304;30268.394632106792;30779.230519237197;31172.049888072106;31215.531767023967;31231.84384078065;23617.40956476102;23834.88082559576;23905.16331928374;23957.28128156158;24287.78561071904 05:57:09 INFO - 2015-12-19 05:57:09,042 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.9548801339987;350.04263339765754;350.9596396414413;351.2518335944439;352.64206830067485;14339.569812905629;14539.78190327146;17148.314067437303;17683.557911052216;18610.53473663159;13758.862411375909;14151.71696566068;16871.83128168721;17126.229319680613;17644.38244661437;5351.812686555981;5455.645383050109;5484.396716361217;5487.122060470326;5487.122060470326;3962.4254483099935;4079.265732168223;5304.469553044703;5473.698946557938;5480.26016487775;5825.970870145643;5943.85140371492;5948.553858460633;5955.166276721263;5977.8206653800235;5783.9710801445935;5888.617239879415;5931.080682494198;5937.851553711149;5940.227770389865;5199.922001169985;5229.973850130763;5233.790648374099;5236.92144617831;5238.319018527605;20887.268945586984;21007.5798484031;21313.786862131336;21372.679409808865;21374.25190118354;2134.8185404240658;2242.327301809467;2268.3421807675754;2333.125078095714;2460.434100156956;13242.20546767197;13279.203247805066;13389;13616.523421680193;13740.65648358789;1702.8807983441163;1782.616737401465;1822.353064662039;1842.5025243184266;1849.4913898677837;58829.70585147047;59427.70286148585;60228.698856505434;60628.696856515875;62334.68832655853;9569;9906.55420506079;9929.553170107363;9956.406974883983;10076.345037572535;12924.159929604733;12994.740105197843;13001.089923705438;13012.47950082005;13017.674558136123;7131.286871312827;7173.0675012248075;7238.276172382825;7333.376662983706;7357.8295746332615;6886.896696549556;6907.447404207752;6971.651417429108;6979.8604027919155;6988.755393561201;5825.097109947965;5874.353821079678;5927.585069045212;5941.257342832146;6078.361772013964;1620.5381466282054;1664.0847533856331;1666.6000159961523;1729.723244280909;1739.5651087228193;956.3496822160997;968.3419014804266;1032.0659802878406;1040.3315495753368;1058.962936297226;15157.317920693595;17357.400288923447;18189.909050454928;18553.44339669812;18897.449799296734;861.3755027604936;960.7550074731039;966.3766870368573;977.4819345746623;998.5933899302646;10157;10308.226882983807;10330.380177189392;10513.211509136845;10539.42033188182;407801;494357.6410589764;499861;501248;503859;75869.6206518975;79329.20670793219;81001.18998810054;81227.5938620315;82790.58604707058;1141.4557798037142;1143.4111432612212;1146.1747541770078;1168.5092261250295;1169.7777422289737;14714.264286785405;15203.92398038047;15546.300416481059;15689.293981771076;15903.840961590236;32483;32769;33058.66941330556;36570.8171459141;37256.44115338326;40850.59149408587;42719.5728042728;42823.5717642832;43737;46015.309770352804;9350.67272645454;9438.95280523593;9664.516774161124;9687.806243875224;9690.12788849007;16347.509574712778;16704.916475417544;16708.74936875972;16835.579110522336;17318.39385621497;14397.496087636882;14528.418863245775;14587.635309116933;14916.328765205808;15124.848751512343;14239.71520569562;14306;14367.353469093707;14653.267336633338;15031.624209394415;14520.564383068524;14590.343434545683;14657.120572765669;14861.85138148648;14872.256387180381;9343;9527.237820974444;9590.42457452555;9606.231501480004;9785.60857565718;14005.929970350084;14197.645058873612;14373.425062997363;14863.777043344142;15047.398104075713 05:57:09 INFO - 2015-12-19 05:57:09,043 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1253.3232054690468;1396.7974643676666;1440.661444560528;1556.252998560691;1749.0380290840042;6466.450351720104;7174.354308112275;7297;7308.524945878514;7308.890366644505;7196.676149573282;7356.485046046779;7360.337569618733;7374.96312518438;7390.630468476582;2165.231342873281;2206.922757703481;2208.205046183373;2210.7678693737166;2213.0815711479718;2170.8046275835172;2202.218212534551;2234.653628687556;2236.0943817753837;2237.7762223777654;2161.7730138335482;2167.512309730314;2182.0726191368685;2191.824654027674;2203.7465691445527;2063.7626672932656;2093.8010888965523;2094.3821572636107;2094.8743075415446;2095.078165607128;2164.599549083425;2226.220822712054;2232.6651002349613;2236.0943817753673;2237.8321625878125;7292.416606671507;7301.561906285639;7306.196318404971;7315.780526584158;7344.30229128232;4422.29243321067;4462.1744977179005;4477.417935668374;4506.8873278167985;4511;2931.88272469101;2970.2277407873894;3026.424979253935;3039.2553824312963;3039.6656367799524;935.5322338830584;955.8948515663271;968.5931908598405;971.4268581536927;979.0698836105657;9638.75903102421;9690.030996900254;9693.854592181124;9701.126898579161;9703.70888873328;3952.604739526082;3997.1006523532556;4015.417764424142;4032.628906171916;4113.177364527107;8293.460925039853;8428.915710842935;8461.957690211633;8476.067632560413;8477.237048665527;4559.202139625552;4587.197240482902;4596.97701511497;4598.793054312564;4604.815807367668;3650.288193802236;3724.8696295630066;4001.079751657135;4214.789260536961;4223.13425747721;3357.2278375973665;3368.79787212768;3376.413085849647;3394.1853955051106;3395.388830010622;1126.6901602059336;1127.2222166705112;1145.3872178384524;1153.6885041038872;1154.1228666213738;970.5729479029346;991.2714155095998;992.2558081438921;1079.4279032112993;1310.5020092364841;6764.661766911635;6811.761588344384;6826.112605361272;6907;6917;459.78849729124977;467.3760529692898;472.3505180376982;476.08591504311113;479.03235464361796;5415.53967912724;5463.207834864002;5467.726613669301;5471.671699698031;5475.72621368938;8448.366372522085;8497.532635704973;8522.190391912758;8524.957375213084;8661.393702440895;8393.286570641441;8483.363747718822;8494.660213591511;8509;8516.957415213008;6707.5304728668525;6794.72821087151;6852.486063545254;6905.861882762317;6910.861782764317;6627.734890604322;6633.2040155181685;6637.137172167587;6652.168478940132;6658.900116498353;7691.077070751546;7723.691052357843;7734.99445072137;7742.303192712683;7787.610619469117;7753;7873.881891771743;7885.6451459685595;7914.960425197837;7921.049474063149;5716.5998380113;6126.111713801563;6485.675716214076;6573.934260657332;6574.671266436755;6437.774677886251;6438.452731517874;6549.410553050057;6551.44312733423;6556.311587283458;6113.877722445615;6224.626522408489;6224.906626400517;6293.905591416224;6413.35866413355;6237.688115594111;6261.123442717932;6296.716647750771;6360.141380913517;6363.204599425072;6188.1955345806555;6209;6224.253089629274;6226.439620434183;6239.220097487814;5800.564957628279;5830.854228644318;5841.8539536510225;5853.94146058534;5882.23530940975;5934.940650593611;6017.338092809875;6203.100550420074;6208.161898143693;6221.377862213742 05:57:09 INFO - 2015-12-19 05:57:09,043 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.5444813916099;320.45202703377237;333.9398908196524;336.64820262825344;342.3256185314929;6007.158997740315;6022.126791615213;6026.246719160105;6056.606320589159;6066.393360663942;5701.857453563663;5768.682722450264;5834.737436815343;5910.852228694274;5922.200502932103;4592.908141837162;4610.170169369512;4610.700304480215;4617.607503362202;4618.445786505624;4413.227685155101;4613.1926912790295;4622.722636641813;4628.722276663394;4631.513691062441;4442.311441726538;4461.799219035135;4568.45178578571;4577.931331030038;4595.977020114895;4560.794764235601;4564.5435456454425;4572.5427457254345;4576.54234576543;4587.036722288323;4022.7787471689044;4047.271491131595;4050.5746896576024;4053.6757059435176;4060.1067765091634;5555.2778138842095;5667.489925906688;5672.829815105553;5673.375928647887;5685.829425117253;5279.1817268323475;5285.603579731497;5299.364076310829;5300.761465734051;5306.973465132688;6318.4629306509005;6319.399657032574;6321.241451025906;6322.778702745428;6323.841903952392;4389.275769498029;4406;4412.382266482695;4413.757243351614;4416.094700586372;6384.904226436607;6434.453071488929;6463.192100987377;6486.545941784077;6507.479401647857;4503.166914120898;4506.59440650343;4507.076049409929;4510.21071312519;4514.841980530666;4557.088582283556;4561.2245918193985;4564.589186973122;4566.58900698932;4568.817247310137;5273.182656688219;5274.287971123926;5275.261463395128;5278.261043453919;5280.498352656491;6195.16365290689;6344.175257216532;6358.33237510064;6360.332165122688;6372.426481616677;1560.5708430181792;1567.130242715304;1570.6780110077407;1571.4735563586098;1571.5206861907;1027.2347101409498;1033.6640591807543;1057.3655806516183;1061.9787604247872;1063.473580577619;6079.665618391031;6081.331053584102;6088.360722124202;6089.54328425361;6094.085887116968;6416.101745755598;6556.737730490822;6561.606303621798;6563.442107420923;6576.638284894377;6007.189029480965;6055.303640081447;6110.7861224856915;6127.816165515042;6144.293406258248;3529.8235088245483;3539.52216450781;3558.768680035841;3564.928701425957;3564.9643503564635;6594.274629790719;6677.866442671119;6724.663766811737;6728;6736.562123462058;6800.353966373186;6804.673088747746;6817.386435220854;6824.522283440111;6828.658567071627;6746.662666866735;6749.392554670103;6753.189617245962;6755.628440435725;6761.816682080715;6491.902621460587;6659.367360100783;6662.100616416722;6664.400203981665;6667.66661666905;6542.803715888531;6544.738210471528;6545.901811472737;6550.443212326815;6551.181102362205;6723;6726.923692209223;6736.461083113437;6737.461003119641;6739.123913891162;4532.070925460207;4542.613877820422;4552.499225085172;4556.362109304766;4560.361549383023;6484.513661475314;6640.83397915056;6649.301823308483;6653.268140504638;6656.434203092597;6453.612783233021;6461.127747754181;6464.967675161594;6468.15913931186;6472.8705425890275;6271.843203919756;6320.4311611955145;6357.777477788441;6382.648954307558;6444.162258906312;6273.96863015682;6279.372062793684;6283.937160628518;6284.151639528605;6322.36776322364;6473.287938326875;6474.902876456951;6475.352464753487;6480.708368123352;6486.4486518646445;6140.078988151813;6280.623162610258;6295.96852015737;6299.023651334051;6306.400891915261 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: |5;yui.html;724.3770357492559;753.2016062973249;753.8190834199787;767.6699019421646;848.6859861851115;13446.394912228949;13863.514776982807;13868.1679099254;13873.583792486217;13877;12109.818352724717;12766.361681915914;12837.871621283784;12864.549740759076;12867.16363436376;776.3672606825447;841.9031811341682;842.5450256861287;842.8862103616025;845.1717317029315;831.8876951611546;832.8417600655886;839.0895877972407;839.215333663024;844.3878188313485;858.9312854971619;861.0270394454258;869.0874581689233;869.6825658634584;869.8216865542548;714.5141303913337;723.3887365176417;844.8859403980476;857.4983634573782;858.7337925243195;637.8692368064536;641.8876696578127;646.5474168082314;646.6540400885551;647.0617604473532;12771.233725976379;12932.612021639367;12970.481180752759;13010.349482525931;13020.153690010118;11737.354445505494;11829.763404731943;12013.09901757363;12240.265584064984;12658.620241392773;10409.427481488516;10474.58101675932;10580.735481612945;10641.201909856714;10719.732006699816;3569.6965757910607;3628.618995005539;3632.9273414531826;3664.6885014773775;3670.6696397324367;46302.76848615769;46340.768296158305;46360;46440.3033954491;46622.067558648974;9379.155875971195;9471.715848524555;9654.903450965541;9807.607695692235;9876.851847222297;18390.632187356445;18487.075646217636;18524;18561.25754969786;18571.535711607317;7413.555186688816;7615.657295421719;7662.770116896502;7757.806054848674;7921.405894557931;3932.941005884914;4123.649489793401;4148.834046638161;4150.315197992358;4152.211079894811;2974.330775575478;3019.773516986235;3019.9849000754857;3020.093971808493;3039.5136778115398;520.7370278009656;532.8401479556118;533.9492748188916;534.3080710479937;551.5008916930185;540.2814257038129;594.9286085669661;599.691159053088;613.8557439001831;640.3052687833659;8321.209485098905;8379.832403351898;8384.287335576422;8706.216440520384;9715.319927605;546.5764032874554;560.3611882454006;568.9815230737017;575.5913301555859;578.4071326889972;3622.7645203062243;3938.8424463021156;3978.640565093772;3979.383195604686;4002.2795896738867;55707;55744;56145.71927140338;56506;56655.43344566502;48314;51170;51817;52347.691307717614;52400.21399679008;42130.36804447936;45621.771891141;46290.76854615705;46762.532374675815;47945.9999999993;8331.95834020826;8373.571664217308;8405.789855253668;8795.912040879764;8799.340049496186;34386.82806585951;34680.65319346875;35464.822675886455;35516.11209719675;37066.44400334051;40360;42290;44015.55984440115;45716.77141614271;46127.53872461232;10760;10855.78288434211;10998.835017474905;11003.669889903316;11816.172867899164;12318.876811231772;12423.254604723385;12460.626181214579;13154.934225328812;13170.539031134247;11311.151663625425;11465.254758440675;11473.713157171138;11600.825987610362;11972.102092343282;11167.218294719292;11190.888091118984;11317.830232546354;11682.591109311474;11724.70688232801;7189.82025449347;10197.388156710622;10974.451277435937;11092.445377731243;11151.553937842395;9927.354721943051;10037.430753106693;10254.23093267993;10352.430616316175;10575.78848423012;8122.878156827771;9099.408538444979;9527.618895244113;9533.647728123473;9719.715152837472 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,844 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: __startTimestamp1450533429035__endTimestamp 05:57:09 INFO - 2015-12-19 05:57:09,045 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5204.50 Median:5353.81 stddev:582.44 (10.9%) stddev-sans-first:558.46 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: Values: 3020.8 3039.5 3085.5 3088.0 3111.0 5037.7 5054.2 5110.2 5176.4 5199.2 5185.1 5236.4 5293.2 5298.5 5309.4 4709.1 4766.3 4774.7 4788.4 4835.5 4752.8 4818.6 4859.2 4870.6 4916.0 4544.2 4643.6 4811.1 4820.7 4857.6 4579.3 4697.5 4726.8 4735.0 4749.7 4690.5 4693.0 4694.8 4723.4 4749.0 4952.4 5017.1 5021.9 5023.4 5038.7 5556.3 5592.4 5610.8 5622.7 5662.9 5711.7 5722.3 5724.5 5725.3 5731.3 5190.4 5300.8 5306.9 5350.6 5353.8 5671.6 5798.4 5805.9 5834.7 5843.6 5457.2 5464.0 5467.5 5469.3 5546.0 5499.7 5580.5 5598.2 5599.8 5620.0 5493.8 5551.6 5568.9 5614.8 5634.6 5660.7 5674.4 5678.3 5685.9 5686.1 4283.0 4382.6 4385.1 4391.5 4433.7 3856.6 3921.9 3933.0 3957.1 3965.5 5264.2 5357.5 5375.1 5381.9 5382.2 5534.4 5632.8 5740.1 5761.5 5761.9 5211.5 5234.5 5236.3 5280.9 5292.6 4861.4 4874.5 4875.0 4878.1 4925.0 5576.3 5638.4 5649.8 5651.4 5746.9 5503.0 5600.9 5604.0 5604.2 5644.0 5808.9 5849.4 5855.3 5857.1 5857.3 5388.7 5496.2 5697.5 5702.2 5715.1 5481.1 5589.2 5599.0 5648.9 5665.8 5487.8 5522.6 5535.4 5536.4 5556.8 5315.3 5349.0 5564.8 5567.8 5616.7 5261.8 5322.8 5323.9 5329.3 5348.5 5398.7 5424.9 5430.0 5475.5 5507.4 5142.5 5247.9 5253.9 5315.0 5332.3 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,046 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47839.35 Median:173333.69 stddev:82756.19 (47.7%) stddev-sans-first:82912.25 05:57:09 INFO - 2015-12-19 05:57:09,048 DEBUG : BROWSER_OUTPUT: Values: 574.1 583.1 585.6 595.2 626.0 30841.7 37369.8 38507.2 38541.0 38552.2 42358.8 42571.1 42572.6 42902.8 43334.6 7517.0 7627.6 8626.0 8812.8 8813.8 10383.2 10642.6 10643.5 10646.3 10650.1 10232.6 10287.3 10316.3 10371.4 10425.2 7821.2 7993.4 10286.2 10589.7 10855.5 10251.8 10376.7 10389.5 10392.5 10395.5 40682.0 41061.0 41154.8 41158.8 41184.4 3220.6 3278.0 3361.4 3470.4 3720.3 29373.0 30054.8 30366.2 31080.1 31190.4 3549.1 3580.3 3592.7 3664.3 3702.1 280952.0 286031.0 286741.0 289817.0 289928.0 54014.7 55027.7 56010.0 56945.4 56966.0 65535.1 66389.7 66432.7 66469.0 66684.7 13327.5 13552.3 13565.7 13574.6 13583.3 10024.4 10067.7 10095.6 10101.5 10154.8 18270.4 18414.3 18649.4 18758.9 18792.8 7392.3 7442.2 7446.5 7612.5 7668.3 918.5 987.8 997.0 1048.0 1137.8 27470.9 28386.4 28509.4 28725.0 28848.6 942.6 1035.4 1091.1 1102.9 1107.9 14485.6 14713.8 14818.5 15095.8 15117.2 340840.0 341605.0 345109.0 345174.0 345213.0 50736.2 51543.2 51741.0 51894.2 51954.0 1138.6 1330.4 1335.9 1350.9 1351.5 27385.7 28254.4 28334.8 28425.0 28757.3 45607.0 46299.3 46329.0 46475.5 46514.0 313184.0 313840.0 314499.0 314501.0 315187.0 27361.3 30878.5 31345.7 31468.8 31744.8 38008.0 40218.4 40572.0 41304.2 41470.0 34352.3 34882.3 34943.7 35114.3 35976.5 29124.2 31480.4 33548.3 34669.1 35076.8 31426.0 31937.5 31977.7 32119.0 32616.2 30268.4 30779.2 31172.0 31215.5 31231.8 23617.4 23834.9 23905.2 23957.3 24287.8 05:57:09 INFO - 2015-12-19 05:57:09,048 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,048 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27327.92 Median:32913.83 stddev:78935.76 (239.8%) stddev-sans-first:79131.20 05:57:09 INFO - 2015-12-19 05:57:09,048 DEBUG : BROWSER_OUTPUT: Values: 349.0 350.0 351.0 351.3 352.6 14339.6 14539.8 17148.3 17683.6 18610.5 13758.9 14151.7 16871.8 17126.2 17644.4 5351.8 5455.6 5484.4 5487.1 5487.1 3962.4 4079.3 5304.5 5473.7 5480.3 5826.0 5943.9 5948.6 5955.2 5977.8 5784.0 5888.6 5931.1 5937.9 5940.2 5199.9 5230.0 5233.8 5236.9 5238.3 20887.3 21007.6 21313.8 21372.7 21374.3 2134.8 2242.3 2268.3 2333.1 2460.4 13242.2 13279.2 13389.0 13616.5 13740.7 1702.9 1782.6 1822.4 1842.5 1849.5 58829.7 59427.7 60228.7 60628.7 62334.7 9569.0 9906.6 9929.6 9956.4 10076.3 12924.2 12994.7 13001.1 13012.5 13017.7 7131.3 7173.1 7238.3 7333.4 7357.8 6886.9 6907.4 6971.7 6979.9 6988.8 5825.1 5874.4 5927.6 5941.3 6078.4 1620.5 1664.1 1666.6 1729.7 1739.6 956.3 968.3 1032.1 1040.3 1059.0 15157.3 17357.4 18189.9 18553.4 18897.4 861.4 960.8 966.4 977.5 998.6 10157.0 10308.2 10330.4 10513.2 10539.4 407801.0 494357.6 499861.0 501248.0 503859.0 75869.6 79329.2 81001.2 81227.6 82790.6 1141.5 1143.4 1146.2 1168.5 1169.8 14714.3 15203.9 15546.3 15689.3 15903.8 32483.0 32769.0 33058.7 36570.8 37256.4 40850.6 42719.6 42823.6 43737.0 46015.3 9350.7 9439.0 9664.5 9687.8 9690.1 16347.5 16704.9 16708.7 16835.6 17318.4 14397.5 14528.4 14587.6 14916.3 15124.8 14239.7 14306.0 14367.4 14653.3 15031.6 14520.6 14590.3 14657.1 14861.9 14872.3 9343.0 9527.2 9590.4 9606.2 9785.6 14005.9 14197.6 14373.4 14863.8 15047.4 05:57:09 INFO - 2015-12-19 05:57:09,049 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,049 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5035.10 Median:6215.19 stddev:2580.15 (41.5%) stddev-sans-first:2571.73 05:57:09 INFO - 2015-12-19 05:57:09,049 DEBUG : BROWSER_OUTPUT: Values: 1253.3 1396.8 1440.7 1556.3 1749.0 6466.5 7174.4 7297.0 7308.5 7308.9 7196.7 7356.5 7360.3 7375.0 7390.6 2165.2 2206.9 2208.2 2210.8 2213.1 2170.8 2202.2 2234.7 2236.1 2237.8 2161.8 2167.5 2182.1 2191.8 2203.7 2063.8 2093.8 2094.4 2094.9 2095.1 2164.6 2226.2 2232.7 2236.1 2237.8 7292.4 7301.6 7306.2 7315.8 7344.3 4422.3 4462.2 4477.4 4506.9 4511.0 2931.9 2970.2 3026.4 3039.3 3039.7 935.5 955.9 968.6 971.4 979.1 9638.8 9690.0 9693.9 9701.1 9703.7 3952.6 3997.1 4015.4 4032.6 4113.2 8293.5 8428.9 8462.0 8476.1 8477.2 4559.2 4587.2 4597.0 4598.8 4604.8 3650.3 3724.9 4001.1 4214.8 4223.1 3357.2 3368.8 3376.4 3394.2 3395.4 1126.7 1127.2 1145.4 1153.7 1154.1 970.6 991.3 992.3 1079.4 1310.5 6764.7 6811.8 6826.1 6907.0 6917.0 459.8 467.4 472.4 476.1 479.0 5415.5 5463.2 5467.7 5471.7 5475.7 8448.4 8497.5 8522.2 8525.0 8661.4 8393.3 8483.4 8494.7 8509.0 8517.0 6707.5 6794.7 6852.5 6905.9 6910.9 6627.7 6633.2 6637.1 6652.2 6658.9 7691.1 7723.7 7735.0 7742.3 7787.6 7753.0 7873.9 7885.6 7915.0 7921.0 5716.6 6126.1 6485.7 6573.9 6574.7 6437.8 6438.5 6549.4 6551.4 6556.3 6113.9 6224.6 6224.9 6293.9 6413.4 6237.7 6261.1 6296.7 6360.1 6363.2 6188.2 6209.0 6224.3 6226.4 6239.2 5800.6 5830.9 5841.9 5853.9 5882.2 5934.9 6017.3 6203.1 6208.2 6221.4 05:57:09 INFO - 2015-12-19 05:57:09,049 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,049 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5316.75 Median:6061.50 stddev:1606.31 (26.5%) stddev-sans-first:1566.39 05:57:09 INFO - 2015-12-19 05:57:09,050 DEBUG : BROWSER_OUTPUT: Values: 318.5 320.5 333.9 336.6 342.3 6007.2 6022.1 6026.2 6056.6 6066.4 5701.9 5768.7 5834.7 5910.9 5922.2 4592.9 4610.2 4610.7 4617.6 4618.4 4413.2 4613.2 4622.7 4628.7 4631.5 4442.3 4461.8 4568.5 4577.9 4596.0 4560.8 4564.5 4572.5 4576.5 4587.0 4022.8 4047.3 4050.6 4053.7 4060.1 5555.3 5667.5 5672.8 5673.4 5685.8 5279.2 5285.6 5299.4 5300.8 5307.0 6318.5 6319.4 6321.2 6322.8 6323.8 4389.3 4406.0 4412.4 4413.8 4416.1 6384.9 6434.5 6463.2 6486.5 6507.5 4503.2 4506.6 4507.1 4510.2 4514.8 4557.1 4561.2 4564.6 4566.6 4568.8 5273.2 5274.3 5275.3 5278.3 5280.5 6195.2 6344.2 6358.3 6360.3 6372.4 1560.6 1567.1 1570.7 1571.5 1571.5 1027.2 1033.7 1057.4 1062.0 1063.5 6079.7 6081.3 6088.4 6089.5 6094.1 6416.1 6556.7 6561.6 6563.4 6576.6 6007.2 6055.3 6110.8 6127.8 6144.3 3529.8 3539.5 3558.8 3564.9 3565.0 6594.3 6677.9 6724.7 6728.0 6736.6 6800.4 6804.7 6817.4 6824.5 6828.7 6746.7 6749.4 6753.2 6755.6 6761.8 6491.9 6659.4 6662.1 6664.4 6667.7 6542.8 6544.7 6545.9 6550.4 6551.2 6723.0 6726.9 6736.5 6737.5 6739.1 4532.1 4542.6 4552.5 4556.4 4560.4 6484.5 6640.8 6649.3 6653.3 6656.4 6453.6 6461.1 6465.0 6468.2 6472.9 6271.8 6320.4 6357.8 6382.6 6444.2 6274.0 6279.4 6283.9 6284.2 6322.4 6473.3 6474.9 6475.4 6480.7 6486.4 6140.1 6280.6 6296.0 6299.0 6306.4 05:57:09 INFO - 2015-12-19 05:57:09,050 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,051 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13644.79 Median:46296.77 stddev:15695.33 (33.9%) stddev-sans-first:15709.37 05:57:09 INFO - 2015-12-19 05:57:09,051 DEBUG : BROWSER_OUTPUT: Values: 724.4 753.2 753.8 767.7 848.7 13446.4 13863.5 13868.2 13873.6 13877.0 12109.8 12766.4 12837.9 12864.5 12867.2 776.4 841.9 842.5 842.9 845.2 831.9 832.8 839.1 839.2 844.4 858.9 861.0 869.1 869.7 869.8 714.5 723.4 844.9 857.5 858.7 637.9 641.9 646.5 646.7 647.1 12771.2 12932.6 12970.5 13010.3 13020.2 11737.4 11829.8 12013.1 12240.3 12658.6 10409.4 10474.6 10580.7 10641.2 10719.7 3569.7 3628.6 3632.9 3664.7 3670.7 46302.8 46340.8 46360.0 46440.3 46622.1 9379.2 9471.7 9654.9 9807.6 9876.9 18390.6 18487.1 18524.0 18561.3 18571.5 7413.6 7615.7 7662.8 7757.8 7921.4 3932.9 4123.6 4148.8 4150.3 4152.2 2974.3 3019.8 3020.0 3020.1 3039.5 520.7 532.8 533.9 534.3 551.5 540.3 594.9 599.7 613.9 640.3 8321.2 8379.8 8384.3 8706.2 9715.3 546.6 560.4 569.0 575.6 578.4 3622.8 3938.8 3978.6 3979.4 4002.3 55707.0 55744.0 56145.7 56506.0 56655.4 48314.0 51170.0 51817.0 52347.7 52400.2 42130.4 45621.8 46290.8 46762.5 47946.0 8332.0 8373.6 8405.8 8795.9 8799.3 34386.8 34680.7 35464.8 35516.1 37066.4 40360.0 42290.0 44015.6 45716.8 46127.5 10760.0 10855.8 10998.8 11003.7 11816.2 12318.9 12423.3 12460.6 13154.9 13170.5 11311.2 11465.3 11473.7 11600.8 11972.1 11167.2 11190.9 11317.8 11682.6 11724.7 7189.8 10197.4 10974.5 11092.4 11151.6 9927.4 10037.4 10254.2 10352.4 10575.8 8122.9 9099.4 9527.6 9533.6 9719.7 05:57:09 INFO - 2015-12-19 05:57:09,051 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:57:09 INFO - 2015-12-19 05:57:09,051 DEBUG : BROWSER_OUTPUT: 05:57:09 INFO - 2015-12-19 05:57:09,769 INFO : Browser exited with error code: 0 05:57:09 INFO - 2015-12-19 05:57:09,793 INFO : Completed test dromaeo_css (00:18:32) 05:57:09 INFO - 2015-12-19 05:57:09,793 INFO : Starting test kraken 05:57:09 INFO - 2015-12-19 05:57:09,793 DEBUG : operating with platform_type : linux_ 05:57:09 INFO - 2015-12-19 05:57:09,793 INFO : Initialising browser for kraken test... 05:57:09 INFO - 2015-12-19 05:57:09,800 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp71Th6s/profile http://localhost:52590/getInfo.html 05:57:13 INFO - 2015-12-19 05:57:13,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:57:13 INFO - 2015-12-19 05:57:13,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:57:13 INFO - 2015-12-19 05:57:13,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:57:13 INFO - 2015-12-19 05:57:13,417 DEBUG : BROWSER_OUTPUT: __metrics 05:57:13 INFO - 2015-12-19 05:57:13,498 DEBUG : BROWSER_OUTPUT: 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:57:13 INFO - 2015-12-19 05:57:13,554 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:14 INFO - 2015-12-19 05:57:14,620 INFO : Browser initialized. 05:57:14 INFO - 2015-12-19 05:57:14,620 INFO : Running cycle 1/1 for kraken test... 05:57:14 INFO - 2015-12-19 05:57:14,621 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp71Th6s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:57:26 INFO - 2015-12-19 05:57:26,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 150409216 05:57:26 INFO - 2015-12-19 05:57:26,426 DEBUG : BROWSER_OUTPUT: 05:57:28 INFO - 2015-12-19 05:57:28,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52590/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:29 INFO - 2015-12-19 05:57:29,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 186314752 05:57:29 INFO - 2015-12-19 05:57:29,483 DEBUG : BROWSER_OUTPUT: 05:57:32 INFO - 2015-12-19 05:57:32,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52590/tests/kraken/driver.html?testName=audio-dft) 05:57:32 INFO - 2015-12-19 05:57:32,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 176156672 05:57:32 INFO - 2015-12-19 05:57:32,659 DEBUG : BROWSER_OUTPUT: 05:57:35 INFO - 2015-12-19 05:57:35,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52590/tests/kraken/driver.html?testName=audio-fft) 05:57:36 INFO - 2015-12-19 05:57:36,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 160911360 05:57:36 INFO - 2015-12-19 05:57:36,078 DEBUG : BROWSER_OUTPUT: 05:57:38 INFO - 2015-12-19 05:57:38,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52590/tests/kraken/driver.html?testName=audio-oscillator) 05:57:38 INFO - 2015-12-19 05:57:38,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 162922496 05:57:38 INFO - 2015-12-19 05:57:38,619 DEBUG : BROWSER_OUTPUT: 05:57:40 INFO - 2015-12-19 05:57:40,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:41 INFO - 2015-12-19 05:57:41,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 164741120 05:57:41 INFO - 2015-12-19 05:57:41,374 DEBUG : BROWSER_OUTPUT: 05:57:44 INFO - 2015-12-19 05:57:44,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52590/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:44 INFO - 2015-12-19 05:57:44,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 164864000 05:57:44 INFO - 2015-12-19 05:57:44,847 DEBUG : BROWSER_OUTPUT: 05:57:48 INFO - 2015-12-19 05:57:48,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52590/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:48 INFO - 2015-12-19 05:57:48,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 165040128 05:57:48 INFO - 2015-12-19 05:57:48,779 DEBUG : BROWSER_OUTPUT: 05:57:51 INFO - 2015-12-19 05:57:51,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52590/tests/kraken/driver.html?testName=json-parse-financial) 05:57:52 INFO - 2015-12-19 05:57:52,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 166662144 05:57:52 INFO - 2015-12-19 05:57:52,097 DEBUG : BROWSER_OUTPUT: 05:57:53 INFO - 2015-12-19 05:57:53,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:54 INFO - 2015-12-19 05:57:54,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 177528832 05:57:54 INFO - 2015-12-19 05:57:54,238 DEBUG : BROWSER_OUTPUT: 05:57:56 INFO - 2015-12-19 05:57:56,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:56 INFO - 2015-12-19 05:57:56,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 173879296 05:57:56 INFO - 2015-12-19 05:57:56,642 DEBUG : BROWSER_OUTPUT: 05:57:58 INFO - 2015-12-19 05:57:58,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:59 INFO - 2015-12-19 05:57:59,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 188252160 05:57:59 INFO - 2015-12-19 05:57:59,295 DEBUG : BROWSER_OUTPUT: 05:58:01 INFO - 2015-12-19 05:58:01,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:02 INFO - 2015-12-19 05:58:02,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 195170304 05:58:02 INFO - 2015-12-19 05:58:02,243 DEBUG : BROWSER_OUTPUT: 05:58:04 INFO - 2015-12-19 05:58:04,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:05 INFO - 2015-12-19 05:58:05,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 194539520 05:58:05 INFO - 2015-12-19 05:58:05,391 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52590/tests/kraken/driver.html?testName=ai-astar) 05:58:07 INFO - 2015-12-19 05:58:07,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 252239872 05:58:07 INFO - 2015-12-19 05:58:07,309 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;107;111;113;112;101;111;112;117 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;124;154;163;134;148;149;130;160;123 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;158;160;158;161;161;162;161;160 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;84;96;72;71;77;99;97;71 05:58:07 INFO - 2015-12-19 05:58:07,313 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;135;92;94;93;137;92;93;137 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;110;111;109;110 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;146;145;146;146;146;145 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;96 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;59;59;60;59;59;69;58;58 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;69;67;67;69;67;68;68;69 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;94;91;84;93;84;85;85;84 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;118;116;117;112;116;122;116;123;118 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;150;154;149;139;151;149;152;141 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;68;67;68;67;69;66;65;65 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1450533487311__endTimestamp 05:58:07 INFO - 2015-12-19 05:58:07,314 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:4.32 (3.9%) stddev-sans-first:4.57 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 107.0 111.0 113.0 112.0 101.0 111.0 112.0 117.0 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:148.50 stddev:14.52 (9.8%) stddev-sans-first:15.34 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: Values: 147.0 124.0 154.0 163.0 134.0 148.0 149.0 130.0 160.0 123.0 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 05:58:07 INFO - 2015-12-19 05:58:07,318 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 158.0 160.0 158.0 161.0 161.0 162.0 161.0 160.0 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:80.50 stddev:11.90 (14.8%) stddev-sans-first:12.26 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 84.0 96.0 72.0 71.0 77.0 99.0 97.0 71.0 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:93.00 stddev:21.02 (22.6%) stddev-sans-first:21.77 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 135.0 92.0 94.0 93.0 137.0 92.0 93.0 137.0 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:58:07 INFO - 2015-12-19 05:58:07,319 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 111.0 109.0 110.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.00 stddev:3.28 (5.6%) stddev-sans-first:3.48 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 59.0 59.0 60.0 59.0 59.0 69.0 58.0 58.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 69.0 67.0 67.0 69.0 67.0 68.0 68.0 69.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.00 stddev:4.13 (4.9%) stddev-sans-first:4.26 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 94.0 91.0 84.0 93.0 84.0 85.0 85.0 84.0 05:58:07 INFO - 2015-12-19 05:58:07,320 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.00 stddev:4.12 (3.5%) stddev-sans-first:3.32 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: Values: 126.0 118.0 116.0 117.0 112.0 116.0 122.0 116.0 123.0 118.0 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.50 stddev:5.70 (3.8%) stddev-sans-first:5.13 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 150.0 154.0 149.0 139.0 151.0 149.0 152.0 141.0 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 68.0 67.0 68.0 67.0 69.0 66.0 65.0 65.0 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:58:07 INFO - 2015-12-19 05:58:07,321 DEBUG : BROWSER_OUTPUT: 05:58:08 INFO - 2015-12-19 05:58:08,141 INFO : Browser exited with error code: 0 05:58:08 INFO - 2015-12-19 05:58:08,195 INFO : Completed test kraken (00:00:58) 05:58:08 INFO - 2015-12-19 05:58:08,195 INFO : Starting test v8_7 05:58:08 INFO - 2015-12-19 05:58:08,195 DEBUG : operating with platform_type : linux_ 05:58:08 INFO - 2015-12-19 05:58:08,195 INFO : Initialising browser for v8_7 test... 05:58:08 INFO - 2015-12-19 05:58:08,201 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVLEkho/profile http://localhost:52590/getInfo.html 05:58:11 INFO - 2015-12-19 05:58:11,819 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:58:11 INFO - 2015-12-19 05:58:11,819 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:58:11 INFO - 2015-12-19 05:58:11,819 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:58:11 INFO - 2015-12-19 05:58:11,819 DEBUG : BROWSER_OUTPUT: __metrics 05:58:11 INFO - 2015-12-19 05:58:11,896 DEBUG : BROWSER_OUTPUT: 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:58:11 INFO - 2015-12-19 05:58:11,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:13 INFO - 2015-12-19 05:58:13,022 INFO : Browser initialized. 05:58:13 INFO - 2015-12-19 05:58:13,023 INFO : Running cycle 1/1 for v8_7 test... 05:58:13 INFO - 2015-12-19 05:58:13,023 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVLEkho/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:58:24 INFO - 2015-12-19 05:58:24,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 149950464 05:58:24 INFO - 2015-12-19 05:58:24,802 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52590/tests/v8_7/run.html (next: http://localhost:52590/tests/v8_7/run.html) 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 560455680 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 05:58:46 INFO - 2015-12-19 05:58:46,409 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.67924528301887 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.4467120181406 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5256.544502617801 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1103.7527593818984 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |8;Splay;586.5102639296188 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: __startTimestamp1450533526406__endTimestamp 05:58:46 INFO - 2015-12-19 05:58:46,410 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: Values: 166.4 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: Values: 188.7 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: Values: 283.4 05:58:46 INFO - 2015-12-19 05:58:46,411 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: Values: 5256.5 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: Values: 1103.8 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,412 DEBUG : BROWSER_OUTPUT: Values: 786.8 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: Values: 12047.6 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: Values: 26000.0 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:586.51 Median:586.51 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: Values: 586.5 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:58:46 INFO - 2015-12-19 05:58:46,413 DEBUG : BROWSER_OUTPUT: 05:58:47 INFO - 2015-12-19 05:58:47,201 INFO : Browser exited with error code: 0 05:58:47 INFO - 2015-12-19 05:58:47,216 INFO : Completed test v8_7 (00:00:39) 05:58:47 INFO - 2015-12-19 05:58:47,462 INFO : Completed test suite (00:20:10) 05:58:47 INFO - 2015-12-19 05:58:47,462 DEBUG : Working with test: dromaeo_css 05:58:47 INFO - 2015-12-19 05:58:47,463 DEBUG : Generating results file: dromaeo_css 05:58:47 INFO - 2015-12-19 05:58:47,463 DEBUG : Working with test: kraken 05:58:47 INFO - 2015-12-19 05:58:47,464 DEBUG : Generating results file: kraken 05:58:47 INFO - 2015-12-19 05:58:47,464 INFO : javascript benchmark 05:58:47 INFO - 2015-12-19 05:58:47,464 DEBUG : Working with test: v8_7 05:58:47 INFO - 2015-12-19 05:58:47,464 DEBUG : Generating results file: v8_7 05:58:47 INFO - 2015-12-19 05:58:47,464 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:47 INFO - 2015-12-19 05:58:47,519 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:58:47 INFO - 2015-12-19 05:58:47,519 DEBUG : process_Request line: dromaeo_css 6869.09 graph.html#tests=[[72,1,35]] 05:58:47 INFO - 2015-12-19 05:58:47,519 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:47 INFO - 2015-12-19 05:58:47,544 DEBUG : process_Request line: kraken 1499.10 graph.html#tests=[[232,1,35]] 05:58:47 INFO - 2015-12-19 05:58:47,544 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:58:47 INFO - 2015-12-19 05:58:47,570 DEBUG : process_Request line: v8_7 21074.97 graph.html#tests=[[230,1,35]] 05:58:47 INFO - 2015-12-19 05:58:47,571 INFO : javascript benchmark 05:58:47 INFO - 2015-12-19 05:58:47,574 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3020.818750874947, 3039.4984827503463, 3085.5217441296595, 3087.9809662811276, 3111.0200286909617, 5037.672551284164, 5054.241863720444, 5110.182370820669, 5176.378834539851, 5199.22011698245, 5185.092608793465, 5236.397814251362, 5293.206019097137, 5298.4701529847, 5309.362876454821, 4709.105269998707, 4766.261229509414, 4774.665773395864, 4788.377510923592, 4835.540623640749, 4752.809887604509, 4818.566329030386, 4859.198232291667, 4870.561649451549, 4916.0, 4544.159330523864, 4643.628509719214, 4811.109944660249, 4820.686655367407, 4857.635677324197, 4579.3131030345385, 4697.530246975275, 4726.810927562893, 4734.976325118387, 4749.7387643679585, 4690.4605970313505, 4692.991006933526, 4694.812207511695, 4723.362346083303, 4749.0, 4952.4057113146655, 5017.122003649347, 5021.899562008776, 5023.447420783711, 5038.672486288379, 5556.277683901067, 5592.440755924375, 5610.775568977236, 5622.746976386073, 5662.886742265173, 5711.657300561979, 5722.256106706143, 5724.484796368305, 5725.255716756837, 5731.312242530923, 5190.377154741455, 5300.814471493556, 5306.92039619406, 5350.625456218067, 5353.812616558402, 5671.602987790898, 5798.391168927286, 5805.854853628609, 5834.708264586754, 5843.620164689281, 5457.2359869618285, 5464.0, 5467.507924286833, 5469.288992430958, 5546.029444847136, 5499.670019798825, 5580.525655319343, 5598.1602759586385, 5599.776008959678, 5620.016497112989, 5493.7802487900035, 5551.639143455663, 5568.9443105568425, 5614.803481878114, 5634.577406694514, 5660.688662123541, 5674.432556744375, 5678.261825962681, 5685.914711279334, 5686.061799803069, 4282.957170428318, 4382.561743825656, 4385.122975404932, 4391.473023237232, 4433.733975961452, 3856.5757766645647, 3921.941170882439, 3933.0, 3957.149212919236, 3965.464662270614, 5264.210368444687, 5357.464253574612, 5375.139977603565, 5381.865453363619, 5382.2464854920345, 5534.446555344433, 5632.802851900164, 5740.13897915316, 5761.452661997104, 5761.884762304814, 5211.478852114834, 5234.528892399702, 5236.266922630834, 5280.9207861882105, 5292.5501332387175, 4861.440934292531, 4874.488178741252, 4875.049365373789, 4878.121938051185, 4924.975375123173, 5576.330840299109, 5638.407967163471, 5649.802256920988, 5651.378348381675, 5746.913796292975, 5502.972485137709, 5600.915986260291, 5604.047311956896, 5604.159376093618, 5644.0, 5808.854778630568, 5849.3858144894175, 5855.268091488564, 5857.121431785266, 5857.26784151981, 5388.703621300866, 5496.1755736639825, 5697.4872261495, 5702.201691763239, 5715.142728590578, 5481.095619222943, 5589.161625756169, 5599.04816181242, 5648.887022259614, 5665.773369065191, 5487.807926722546, 5522.558195344443, 5535.3634332050715, 5536.363318218457, 5556.833295001156, 5315.282436870973, 5349.0, 5564.805231817029, 5567.805126820542, 5616.719164041863, 5261.763220655156, 5322.760475778677, 5323.920141197963, 5329.333833270841, 5348.465153484621, 5398.676079435247, 5424.918626220689, 5429.972850135724, 5475.534579560782, 5507.366652834975, 5142.51146141116, 5247.868803279948, 5253.894922101613, 5314.97342513285, 5332.33345831771], "unit": "score", "name": "dojo.html", "value": 5166.33954011205}, {"lowerIsBetter": false, "replicates": [574.1072632057151, 583.1253120319519, 585.6105689716339, 595.1667665268626, 625.9655718935456, 30841.69158308416, 37369.81315093424, 38507.229855402875, 38541.0, 38552.22895542088, 42358.788206058925, 42571.14857702844, 42572.57427425725, 42902.78548607261, 43334.566654333445, 7516.962415187916, 7627.580483073429, 8625.95687021564, 8812.823743525125, 8813.779655508599, 10383.169346452303, 10642.574297028148, 10643.467826608678, 10646.307989980665, 10650.147988160967, 10232.641857534987, 10287.331323463988, 10316.277860549764, 10371.429571373572, 10425.218108641844, 7821.217878212218, 7993.4004949628425, 10286.177105831515, 10589.735256618646, 10855.45722713869, 10251.84622230667, 10376.688699338956, 10389.480525973671, 10392.53233604482, 10395.480225988671, 40682.0, 41061.0, 41154.79422602898, 41158.79420602908, 41184.38223426651, 3220.6296275928335, 3278.0329802708256, 3361.4285571452665, 3470.3753324401596, 3720.293144302601, 29373.001115656378, 30054.84972575145, 30366.240843978856, 31080.067597972098, 31190.376192476022, 3549.112721819545, 3580.2660454606744, 3592.6766591006935, 3664.3404187246283, 3702.129999450127, 280952.0, 286031.0, 286741.0, 289817.0, 289928.0, 54014.72992635012, 55027.724861376235, 56010.0, 56945.43054569484, 56966.0, 65535.118812524954, 66389.66805165944, 66432.6678366605, 66469.0, 66684.66549674256, 13327.533536326377, 13552.254625995665, 13565.660858478617, 13574.59276221715, 13583.252921089237, 10024.448655323882, 10067.69796906094, 10095.646652367132, 10101.494925253708, 10154.847677284699, 18270.360537381395, 18414.26342946294, 18649.440516784518, 18758.906205468884, 18792.812071879107, 7392.260773922565, 7442.18136005039, 7446.515976461513, 7612.543247405173, 7668.271514206142, 918.5040078357612, 987.8468837330225, 997.0, 1047.994760026195, 1137.766757814646, 27470.862645687044, 28386.43227135487, 28509.429811403657, 28725.0, 28848.567271490945, 942.641796117471, 1035.3529044347283, 1091.0562363555625, 1102.9117670586495, 1107.9058280046124, 14485.637859053397, 14713.779293310608, 14818.481353152589, 15095.773563396559, 15117.16855572932, 340840.0, 341605.0, 345109.0, 345174.0, 345213.0, 50736.238956415684, 51543.226851597254, 51741.0, 51894.22158667623, 51953.96092078213, 1138.6014894786924, 1330.381372661717, 1335.9265240411871, 1350.9459621615222, 1351.49319005373, 27385.726142739113, 28254.434911301247, 28334.79683882803, 28425.0, 28757.28106797347, 45607.0, 46299.305510418046, 46329.0, 46475.53524464712, 46514.0, 313184.0, 313840.0, 314499.0, 314501.0, 315187.0, 27361.31596710098, 30878.53682194724, 31345.686543134278, 31468.842655786575, 31744.8412757944, 38008.0, 40218.39672404858, 40572.0, 41304.1739165221, 41470.0, 34352.312953740286, 34882.30235395227, 34943.65056349404, 35114.297714046086, 35976.460353095244, 29124.232217158038, 31480.37039259248, 33548.25260211112, 34669.13327166841, 35076.82461587676, 31426.0, 31937.520937185494, 31977.68022319747, 32119.0, 32616.184595385304, 30268.394632106792, 30779.230519237197, 31172.049888072106, 31215.531767023967, 31231.84384078065, 23617.40956476102, 23834.88082559576, 23905.16331928374, 23957.28128156158, 24287.78561071904], "unit": "score", "name": "ext.html", "value": 18445.322370123886}, {"lowerIsBetter": false, "replicates": [348.9548801339987, 350.04263339765754, 350.9596396414413, 351.2518335944439, 352.64206830067485, 14339.569812905629, 14539.78190327146, 17148.314067437303, 17683.557911052216, 18610.53473663159, 13758.862411375909, 14151.71696566068, 16871.83128168721, 17126.229319680613, 17644.38244661437, 5351.812686555981, 5455.645383050109, 5484.396716361217, 5487.122060470326, 5487.122060470326, 3962.4254483099935, 4079.265732168223, 5304.469553044703, 5473.698946557938, 5480.26016487775, 5825.970870145643, 5943.85140371492, 5948.553858460633, 5955.166276721263, 5977.8206653800235, 5783.9710801445935, 5888.617239879415, 5931.080682494198, 5937.851553711149, 5940.227770389865, 5199.922001169985, 5229.973850130763, 5233.790648374099, 5236.92144617831, 5238.319018527605, 20887.268945586984, 21007.5798484031, 21313.786862131336, 21372.679409808865, 21374.25190118354, 2134.8185404240658, 2242.327301809467, 2268.3421807675754, 2333.125078095714, 2460.434100156956, 13242.20546767197, 13279.203247805066, 13389.0, 13616.523421680193, 13740.65648358789, 1702.8807983441163, 1782.616737401465, 1822.353064662039, 1842.5025243184266, 1849.4913898677837, 58829.70585147047, 59427.70286148585, 60228.698856505434, 60628.696856515875, 62334.68832655853, 9569.0, 9906.55420506079, 9929.553170107363, 9956.406974883983, 10076.345037572535, 12924.159929604733, 12994.740105197843, 13001.089923705438, 13012.47950082005, 13017.674558136123, 7131.286871312827, 7173.0675012248075, 7238.276172382825, 7333.376662983706, 7357.8295746332615, 6886.896696549556, 6907.447404207752, 6971.651417429108, 6979.8604027919155, 6988.755393561201, 5825.097109947965, 5874.353821079678, 5927.585069045212, 5941.257342832146, 6078.361772013964, 1620.5381466282054, 1664.0847533856331, 1666.6000159961523, 1729.723244280909, 1739.5651087228193, 956.3496822160997, 968.3419014804266, 1032.0659802878406, 1040.3315495753368, 1058.962936297226, 15157.317920693595, 17357.400288923447, 18189.909050454928, 18553.44339669812, 18897.449799296734, 861.3755027604936, 960.7550074731039, 966.3766870368573, 977.4819345746623, 998.5933899302646, 10157.0, 10308.226882983807, 10330.380177189392, 10513.211509136845, 10539.42033188182, 407801.0, 494357.6410589764, 499861.0, 501248.0, 503859.0, 75869.6206518975, 79329.20670793219, 81001.18998810054, 81227.5938620315, 82790.58604707058, 1141.4557798037142, 1143.4111432612212, 1146.1747541770078, 1168.5092261250295, 1169.7777422289737, 14714.264286785405, 15203.92398038047, 15546.300416481059, 15689.293981771076, 15903.840961590236, 32483.0, 32769.0, 33058.66941330556, 36570.8171459141, 37256.44115338326, 40850.59149408587, 42719.5728042728, 42823.5717642832, 43737.0, 46015.309770352804, 9350.67272645454, 9438.95280523593, 9664.516774161124, 9687.806243875224, 9690.12788849007, 16347.509574712778, 16704.916475417544, 16708.74936875972, 16835.579110522336, 17318.39385621497, 14397.496087636882, 14528.418863245775, 14587.635309116933, 14916.328765205808, 15124.848751512343, 14239.71520569562, 14306.0, 14367.353469093707, 14653.267336633338, 15031.624209394415, 14520.564383068524, 14590.343434545683, 14657.120572765669, 14861.85138148648, 14872.256387180381, 9343.0, 9527.237820974444, 9590.42457452555, 9606.231501480004, 9785.60857565718, 14005.929970350084, 14197.645058873612, 14373.425062997363, 14863.777043344142, 15047.398104075713], "unit": "score", "name": "jquery.html", "value": 9033.205392902852}, {"lowerIsBetter": false, "replicates": [1253.3232054690468, 1396.7974643676666, 1440.661444560528, 1556.252998560691, 1749.0380290840042, 6466.450351720104, 7174.354308112275, 7297.0, 7308.524945878514, 7308.890366644505, 7196.676149573282, 7356.485046046779, 7360.337569618733, 7374.96312518438, 7390.630468476582, 2165.231342873281, 2206.922757703481, 2208.205046183373, 2210.7678693737166, 2213.0815711479718, 2170.8046275835172, 2202.218212534551, 2234.653628687556, 2236.0943817753837, 2237.7762223777654, 2161.7730138335482, 2167.512309730314, 2182.0726191368685, 2191.824654027674, 2203.7465691445527, 2063.7626672932656, 2093.8010888965523, 2094.3821572636107, 2094.8743075415446, 2095.078165607128, 2164.599549083425, 2226.220822712054, 2232.6651002349613, 2236.0943817753673, 2237.8321625878125, 7292.416606671507, 7301.561906285639, 7306.196318404971, 7315.780526584158, 7344.30229128232, 4422.29243321067, 4462.1744977179005, 4477.417935668374, 4506.8873278167985, 4511.0, 2931.88272469101, 2970.2277407873894, 3026.424979253935, 3039.2553824312963, 3039.6656367799524, 935.5322338830584, 955.8948515663271, 968.5931908598405, 971.4268581536927, 979.0698836105657, 9638.75903102421, 9690.030996900254, 9693.854592181124, 9701.126898579161, 9703.70888873328, 3952.604739526082, 3997.1006523532556, 4015.417764424142, 4032.628906171916, 4113.177364527107, 8293.460925039853, 8428.915710842935, 8461.957690211633, 8476.067632560413, 8477.237048665527, 4559.202139625552, 4587.197240482902, 4596.97701511497, 4598.793054312564, 4604.815807367668, 3650.288193802236, 3724.8696295630066, 4001.079751657135, 4214.789260536961, 4223.13425747721, 3357.2278375973665, 3368.79787212768, 3376.413085849647, 3394.1853955051106, 3395.388830010622, 1126.6901602059336, 1127.2222166705112, 1145.3872178384524, 1153.6885041038872, 1154.1228666213738, 970.5729479029346, 991.2714155095998, 992.2558081438921, 1079.4279032112993, 1310.5020092364841, 6764.661766911635, 6811.761588344384, 6826.112605361272, 6907.0, 6917.0, 459.78849729124977, 467.3760529692898, 472.3505180376982, 476.08591504311113, 479.03235464361796, 5415.53967912724, 5463.207834864002, 5467.726613669301, 5471.671699698031, 5475.72621368938, 8448.366372522085, 8497.532635704973, 8522.190391912758, 8524.957375213084, 8661.393702440895, 8393.286570641441, 8483.363747718822, 8494.660213591511, 8509.0, 8516.957415213008, 6707.5304728668525, 6794.72821087151, 6852.486063545254, 6905.861882762317, 6910.861782764317, 6627.734890604322, 6633.2040155181685, 6637.137172167587, 6652.168478940132, 6658.900116498353, 7691.077070751546, 7723.691052357843, 7734.99445072137, 7742.303192712683, 7787.610619469117, 7753.0, 7873.881891771743, 7885.6451459685595, 7914.960425197837, 7921.049474063149, 5716.5998380113, 6126.111713801563, 6485.675716214076, 6573.934260657332, 6574.671266436755, 6437.774677886251, 6438.452731517874, 6549.410553050057, 6551.44312733423, 6556.311587283458, 6113.877722445615, 6224.626522408489, 6224.906626400517, 6293.905591416224, 6413.35866413355, 6237.688115594111, 6261.123442717932, 6296.716647750771, 6360.141380913517, 6363.204599425072, 6188.1955345806555, 6209.0, 6224.253089629274, 6226.439620434183, 6239.220097487814, 5800.564957628279, 5830.854228644318, 5841.8539536510225, 5853.94146058534, 5882.23530940975, 5934.940650593611, 6017.338092809875, 6203.100550420074, 6208.161898143693, 6221.377862213742], "unit": "score", "name": "mootools.html", "value": 4097.238632513848}, {"lowerIsBetter": false, "replicates": [318.5444813916099, 320.45202703377237, 333.9398908196524, 336.64820262825344, 342.3256185314929, 6007.158997740315, 6022.126791615213, 6026.246719160105, 6056.606320589159, 6066.393360663942, 5701.857453563663, 5768.682722450264, 5834.737436815343, 5910.852228694274, 5922.200502932103, 4592.908141837162, 4610.170169369512, 4610.700304480215, 4617.607503362202, 4618.445786505624, 4413.227685155101, 4613.1926912790295, 4622.722636641813, 4628.722276663394, 4631.513691062441, 4442.311441726538, 4461.799219035135, 4568.45178578571, 4577.931331030038, 4595.977020114895, 4560.794764235601, 4564.5435456454425, 4572.5427457254345, 4576.54234576543, 4587.036722288323, 4022.7787471689044, 4047.271491131595, 4050.5746896576024, 4053.6757059435176, 4060.1067765091634, 5555.2778138842095, 5667.489925906688, 5672.829815105553, 5673.375928647887, 5685.829425117253, 5279.1817268323475, 5285.603579731497, 5299.364076310829, 5300.761465734051, 5306.973465132688, 6318.4629306509005, 6319.399657032574, 6321.241451025906, 6322.778702745428, 6323.841903952392, 4389.275769498029, 4406.0, 4412.382266482695, 4413.757243351614, 4416.094700586372, 6384.904226436607, 6434.453071488929, 6463.192100987377, 6486.545941784077, 6507.479401647857, 4503.166914120898, 4506.59440650343, 4507.076049409929, 4510.21071312519, 4514.841980530666, 4557.088582283556, 4561.2245918193985, 4564.589186973122, 4566.58900698932, 4568.817247310137, 5273.182656688219, 5274.287971123926, 5275.261463395128, 5278.261043453919, 5280.498352656491, 6195.16365290689, 6344.175257216532, 6358.33237510064, 6360.332165122688, 6372.426481616677, 1560.5708430181792, 1567.130242715304, 1570.6780110077407, 1571.4735563586098, 1571.5206861907, 1027.2347101409498, 1033.6640591807543, 1057.3655806516183, 1061.9787604247872, 1063.473580577619, 6079.665618391031, 6081.331053584102, 6088.360722124202, 6089.54328425361, 6094.085887116968, 6416.101745755598, 6556.737730490822, 6561.606303621798, 6563.442107420923, 6576.638284894377, 6007.189029480965, 6055.303640081447, 6110.7861224856915, 6127.816165515042, 6144.293406258248, 3529.8235088245483, 3539.52216450781, 3558.768680035841, 3564.928701425957, 3564.9643503564635, 6594.274629790719, 6677.866442671119, 6724.663766811737, 6728.0, 6736.562123462058, 6800.353966373186, 6804.673088747746, 6817.386435220854, 6824.522283440111, 6828.658567071627, 6746.662666866735, 6749.392554670103, 6753.189617245962, 6755.628440435725, 6761.816682080715, 6491.902621460587, 6659.367360100783, 6662.100616416722, 6664.400203981665, 6667.66661666905, 6542.803715888531, 6544.738210471528, 6545.901811472737, 6550.443212326815, 6551.181102362205, 6723.0, 6726.923692209223, 6736.461083113437, 6737.461003119641, 6739.123913891162, 4532.070925460207, 4542.613877820422, 4552.499225085172, 4556.362109304766, 4560.361549383023, 6484.513661475314, 6640.83397915056, 6649.301823308483, 6653.268140504638, 6656.434203092597, 6453.612783233021, 6461.127747754181, 6464.967675161594, 6468.15913931186, 6472.8705425890275, 6271.843203919756, 6320.4311611955145, 6357.777477788441, 6382.648954307558, 6444.162258906312, 6273.96863015682, 6279.372062793684, 6283.937160628518, 6284.151639528605, 6322.36776322364, 6473.287938326875, 6474.902876456951, 6475.352464753487, 6480.708368123352, 6486.4486518646445, 6140.078988151813, 6280.623162610258, 6295.96852015737, 6299.023651334051, 6306.400891915261], "unit": "score", "name": "prototype.html", "value": 4788.217335008194}, {"lowerIsBetter": false, "replicates": [724.3770357492559, 753.2016062973249, 753.8190834199787, 767.6699019421646, 848.6859861851115, 13446.394912228949, 13863.514776982807, 13868.1679099254, 13873.583792486217, 13877.0, 12109.818352724717, 12766.361681915914, 12837.871621283784, 12864.549740759076, 12867.16363436376, 776.3672606825447, 841.9031811341682, 842.5450256861287, 842.8862103616025, 845.1717317029315, 831.8876951611546, 832.8417600655886, 839.0895877972407, 839.215333663024, 844.3878188313485, 858.9312854971619, 861.0270394454258, 869.0874581689233, 869.6825658634584, 869.8216865542548, 714.5141303913337, 723.3887365176417, 844.8859403980476, 857.4983634573782, 858.7337925243195, 637.8692368064536, 641.8876696578127, 646.5474168082314, 646.6540400885551, 647.0617604473532, 12771.233725976379, 12932.612021639367, 12970.481180752759, 13010.349482525931, 13020.153690010118, 11737.354445505494, 11829.763404731943, 12013.09901757363, 12240.265584064984, 12658.620241392773, 10409.427481488516, 10474.58101675932, 10580.735481612945, 10641.201909856714, 10719.732006699816, 3569.6965757910607, 3628.618995005539, 3632.9273414531826, 3664.6885014773775, 3670.6696397324367, 46302.76848615769, 46340.768296158305, 46360.0, 46440.3033954491, 46622.067558648974, 9379.155875971195, 9471.715848524555, 9654.903450965541, 9807.607695692235, 9876.851847222297, 18390.632187356445, 18487.075646217636, 18524.0, 18561.25754969786, 18571.535711607317, 7413.555186688816, 7615.657295421719, 7662.770116896502, 7757.806054848674, 7921.405894557931, 3932.941005884914, 4123.649489793401, 4148.834046638161, 4150.315197992358, 4152.211079894811, 2974.330775575478, 3019.773516986235, 3019.9849000754857, 3020.093971808493, 3039.5136778115398, 520.7370278009656, 532.8401479556118, 533.9492748188916, 534.3080710479937, 551.5008916930185, 540.2814257038129, 594.9286085669661, 599.691159053088, 613.8557439001831, 640.3052687833659, 8321.209485098905, 8379.832403351898, 8384.287335576422, 8706.216440520384, 9715.319927605, 546.5764032874554, 560.3611882454006, 568.9815230737017, 575.5913301555859, 578.4071326889972, 3622.7645203062243, 3938.8424463021156, 3978.640565093772, 3979.383195604686, 4002.2795896738867, 55707.0, 55744.0, 56145.71927140338, 56506.0, 56655.43344566502, 48314.0, 51170.0, 51817.0, 52347.691307717614, 52400.21399679008, 42130.36804447936, 45621.771891141, 46290.76854615705, 46762.532374675815, 47945.9999999993, 8331.95834020826, 8373.571664217308, 8405.789855253668, 8795.912040879764, 8799.340049496186, 34386.82806585951, 34680.65319346875, 35464.822675886455, 35516.11209719675, 37066.44400334051, 40360.0, 42290.0, 44015.55984440115, 45716.77141614271, 46127.53872461232, 10760.0, 10855.78288434211, 10998.835017474905, 11003.669889903316, 11816.172867899164, 12318.876811231772, 12423.254604723385, 12460.626181214579, 13154.934225328812, 13170.539031134247, 11311.151663625425, 11465.254758440675, 11473.713157171138, 11600.825987610362, 11972.102092343282, 11167.218294719292, 11190.888091118984, 11317.830232546354, 11682.591109311474, 11724.70688232801, 7189.82025449347, 10197.388156710622, 10974.451277435937, 11092.445377731243, 11151.553937842395, 9927.354721943051, 10037.430753106693, 10254.23093267993, 10352.430616316175, 10575.78848423012, 8122.878156827771, 9099.408538444979, 9527.618895244113, 9533.647728123473, 9719.715152837472], "unit": "score", "name": "yui.html", "value": 6219.814294795465}], "name": "dromaeo_css", "value": 6869.093217746277}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 111.0, 113.0, 112.0, 101.0, 111.0, 112.0, 117.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [147.0, 124.0, 154.0, 163.0, 134.0, 148.0, 149.0, 130.0, 160.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 158.0, 160.0, 158.0, 161.0, 161.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 84.0, 96.0, 72.0, 71.0, 77.0, 99.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 135.0, 92.0, 94.0, 93.0, 137.0, 92.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 69.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 67.0, 67.0, 69.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 94.0, 91.0, 84.0, 93.0, 84.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [126.0, 118.0, 116.0, 117.0, 112.0, 116.0, 122.0, 116.0, 123.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 150.0, 154.0, 149.0, 139.0, 151.0, 149.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 67.0, 68.0, 67.0, 69.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1499.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1103.7527593818984], "unit": "score", "name": "RayTrace", "value": 670.4300340000001}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [586.5102639296188], "unit": "score", "name": "Splay", "value": 138.94215499999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21074.971418306377}]} 05:58:47 INFO - RETURN: dromaeo_css: 6869.09 05:58:47 INFO - RETURN: kraken: 1499.10 05:58:47 INFO - RETURN: v8_7: 21074.97 05:58:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21074.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6869.09"}}} 05:58:47 INFO - Return code: 0 05:58:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:47 ERROR - # TBPL SUCCESS # 05:58:47 INFO - Running post-action listener: _resource_record_post_action 05:58:47 INFO - Running post-run listener: _resource_record_post_run 05:58:48 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 2654208; Write bytes: 545492992; Read time: 1320; Write time: 671904 05:58:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234483712; Read time: 0; Write time: 430596 05:58:48 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 2654208; Write bytes: 311009280; Read time: 1320; Write time: 241308 05:58:48 INFO - Running post-run listener: _upload_blobber_files 05:58:48 INFO - Blob upload gear active. 05:58:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:58:48 INFO - Copying logs to upload dir... 05:58:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.946445 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-19 05:58:48.760535) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 05:58:48.764516) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009998 build_url: 'https://queue.taskcluster.net/v1/task/j2PMn7dYSauNl_03Hun3Dw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 05:58:48.816162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:58:48.816506) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450525812.546484-2072332917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 05:58:48.866120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 05:58:48.866482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 05:58:48.866796) ========= ========= Total master_lag: 0.26 =========