builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1450618353.46 results: success (0) buildid: 20151220030223 builduid: 69962deddfc8411ab7342ec9ab7380f5 revision: 388bdc46ba51ee31da8b8abe977e0ca38d117434 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.464822) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.465490) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.465846) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.517636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.517982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.604238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.604583) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.655105) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.655431) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.655857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.656173) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 05:32:36-- 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% 39.9M=0s 2015-12-20 05:32:36 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.798608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.798935) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.849144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:33.849508) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 388bdc46ba51ee31da8b8abe977e0ca38d117434 --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 388bdc46ba51ee31da8b8abe977e0ca38d117434 --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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 05:32:36,679 truncating revision to first 12 chars 2015-12-20 05:32:36,679 Setting DEBUG logging. 2015-12-20 05:32:36,679 attempt 1/10 2015-12-20 05:32:36,679 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/388bdc46ba51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 05:32:37,012 unpacking tar archive at: mozilla-central-388bdc46ba51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:34.722253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:34.722607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:34.731347) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:34.731716) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 05:32:34.732198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-20 05:32:34.732534) ========= /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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:37 INFO - MultiFileLogger online at 20151220 05:32:37 in /builds/slave/test-pgo 05:32:37 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:32:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:32:37 INFO - {'append_to_log': False, 05:32:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:32:37 INFO - 'blob_upload_branch': 'Firefox', 05:32:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:32:37 INFO - 'branch': 'Firefox', 05:32:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:37 INFO - 'config_files': ('talos/linux_config.py',), 05:32:37 INFO - 'default_actions': ('clobber', 05:32:37 INFO - 'read-buildbot-config', 05:32:37 INFO - 'download-and-extract', 05:32:37 INFO - 'populate-webroot', 05:32:37 INFO - 'create-virtualenv', 05:32:37 INFO - 'install', 05:32:37 INFO - 'run-tests'), 05:32:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:37 INFO - 'download_minidump_stackwalk': True, 05:32:37 INFO - 'download_symbols': 'ondemand', 05:32:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:37 INFO - 'installer_path': 'installer.exe', 05:32:37 INFO - 'log_level': 'info', 05:32:37 INFO - 'log_name': 'talos', 05:32:37 INFO - 'log_to_console': True, 05:32:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:37 INFO - 'opt_config_files': (), 05:32:37 INFO - 'pip_index': False, 05:32:37 INFO - 'sps_profile': False, 05:32:37 INFO - 'sps_profile_interval': 0, 05:32:37 INFO - 'suite': 'dromaeojs', 05:32:37 INFO - 'system_bits': '64', 05:32:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:37 INFO - 'title': 'talos-linux64-ix-053', 05:32:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:37 INFO - 'use_talos_json': True, 05:32:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:32:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:37 INFO - 'work_dir': 'build'} 05:32:37 INFO - ##### 05:32:37 INFO - ##### Running clobber step. 05:32:37 INFO - ##### 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: clobber 05:32:37 INFO - rmtree: /builds/slave/test-pgo/build 05:32:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:32:38 INFO - Running post-action listener: _resource_record_post_action 05:32:38 INFO - ##### 05:32:38 INFO - ##### Running read-buildbot-config step. 05:32:38 INFO - ##### 05:32:38 INFO - Running pre-action listener: _resource_record_pre_action 05:32:38 INFO - Running main action method: read_buildbot_config 05:32:38 INFO - Using buildbot properties: 05:32:38 INFO - { 05:32:38 INFO - "project": "", 05:32:38 INFO - "product": "firefox", 05:32:38 INFO - "script_repo_revision": "production", 05:32:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:32:38 INFO - "repository": "", 05:32:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:32:38 INFO - "buildid": "20151220030223", 05:32:38 INFO - "stage_platform": "linux64-pgo", 05:32:38 INFO - "basedir": "/builds/slave/test-pgo", 05:32:38 INFO - "nightly_build": "True", 05:32:38 INFO - "buildnumber": 289, 05:32:38 INFO - "slavename": "talos-linux64-ix-053", 05:32:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:32:38 INFO - "platform": "ubuntu64_hw", 05:32:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:32:38 INFO - "branch": "mozilla-central", 05:32:38 INFO - "repo_path": "mozilla-central", 05:32:38 INFO - "revision": "388bdc46ba51ee31da8b8abe977e0ca38d117434", 05:32:38 INFO - "pgo_build": "True", 05:32:38 INFO - "builduid": "69962deddfc8411ab7342ec9ab7380f5", 05:32:38 INFO - "slavebuilddir": "test" 05:32:38 INFO - } 05:32:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:32:38 INFO - Running post-action listener: _resource_record_post_action 05:32:38 INFO - ##### 05:32:38 INFO - ##### Running download-and-extract step. 05:32:38 INFO - ##### 05:32:38 INFO - Running pre-action listener: _resource_record_pre_action 05:32:38 INFO - Running main action method: download_and_extract 05:32:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:38 INFO - https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:32:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/test_packages.json 05:32:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/test_packages.json 05:32:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:32:40 INFO - Downloaded 1302 bytes. 05:32:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:32:40 INFO - Using the following test package requirements: 05:32:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:32:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'jsshell-linux-x86_64.zip'], 05:32:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:32:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:32:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:32:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:32:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:32:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:40 INFO - https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:41 INFO - Downloaded 23120960 bytes. 05:32:41 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:32:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:41 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:32:42 INFO - Return code: 0 05:32:42 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:32:42 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:32:42 INFO - https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:44 INFO - Downloaded 23120960 bytes. 05:32:44 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:32:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:32:44 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:32:45 INFO - Return code: 0 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:45 INFO - https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:46 INFO - Downloaded 11132039 bytes. 05:32:46 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:32:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:46 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:32:47 INFO - Return code: 0 05:32:47 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:32:47 INFO - https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9F5c3q79SpuVjSjdwSVq7A/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:32:49 INFO - Downloaded 54644693 bytes. 05:32:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:49 INFO - mkdir: /builds/slave/test-pgo/properties 05:32:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:32:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:32:49 INFO - Contents: 05:32:49 INFO - build_url:https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:32:49 INFO - Running post-action listener: _resource_record_post_action 05:32:49 INFO - Running post-action listener: set_extra_try_arguments 05:32:49 INFO - ##### 05:32:49 INFO - ##### Running populate-webroot step. 05:32:49 INFO - ##### 05:32:49 INFO - Running pre-action listener: _resource_record_pre_action 05:32:49 INFO - Running main action method: populate_webroot 05:32:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:49 INFO - '--tppagecycles', 05:32:49 INFO - '7'], 05:32:49 INFO - 'tests': ['tsvgm']}}, 05:32:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:32:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'tests': ['damp', 'tps']}, 05:32:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['damp', 'tps']}, 05:32:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:32:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:49 INFO - 'other': {'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'other_l64': {'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:32:49 INFO - 'ts_paint', 05:32:49 INFO - 'tpaint', 05:32:49 INFO - 'sessionrestore', 05:32:49 INFO - 'sessionrestore_no_auto_restore']}, 05:32:49 INFO - 'svgr': {'tests': ['tsvgx', 05:32:49 INFO - 'tsvgr_opacity', 05:32:49 INFO - 'tart', 05:32:49 INFO - 'tscrollx', 05:32:49 INFO - 'cart']}, 05:32:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['tsvgx', 05:32:49 INFO - 'tsvgr_opacity', 05:32:49 INFO - 'tart', 05:32:49 INFO - 'tscrollx', 05:32:49 INFO - 'cart']}, 05:32:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'tests': ['tp5o']}, 05:32:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'talos_options': ['--e10s'], 05:32:49 INFO - 'tests': ['tp5o']}, 05:32:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'talos_options': ['--xperf_path', 05:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:49 INFO - 'tests': ['tp5n']}, 05:32:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:49 INFO - 'talos_options': ['--e10s', 05:32:49 INFO - '--xperf_path', 05:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:49 INFO - 'tests': ['tp5n']}}, 05:32:49 INFO - 'talos.zip': {'path': '', 05:32:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:49 INFO - Running post-action listener: _resource_record_post_action 05:32:49 INFO - ##### 05:32:49 INFO - ##### Running create-virtualenv step. 05:32:49 INFO - ##### 05:32:49 INFO - Running pre-action listener: _resource_record_pre_action 05:32:49 INFO - Running main action method: create_virtualenv 05:32:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:32:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:32:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:32:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:49 INFO - Using real prefix '/usr' 05:32:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:32:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:52 INFO - Installing pip.................done. 05:32:52 INFO - Return code: 0 05:32:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 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 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:32:52 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:32:52 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:32:52 INFO - Using env: {'DISPLAY': ':0', 05:32:52 INFO - 'HOME': '/home/cltbld', 05:32:52 INFO - 'LANG': 'en_US.UTF-8', 05:32:52 INFO - 'LANGUAGE': 'en_US:en', 05:32:52 INFO - 'LOGNAME': 'cltbld', 05:32:52 INFO - 'MAIL': '/var/mail/cltbld', 05:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:52 INFO - 'MOZ_NO_REMOTE': '1', 05:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:52 INFO - 'NO_EM_RESTART': '1', 05:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:52 INFO - 'SHELL': '/bin/bash', 05:32:52 INFO - 'SHLVL': '1', 05:32:52 INFO - 'TERM': 'linux', 05:32:52 INFO - 'TMOUT': '86400', 05:32:52 INFO - 'USER': 'cltbld', 05:32:52 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:52 INFO - '_': '/tools/buildbot/bin/python'} 05:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:52 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:32:52 INFO - Cleaning up... 05:32:52 INFO - Return code: 0 05:32:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 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 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:32:52 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:32:52 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:32:52 INFO - Using env: {'DISPLAY': ':0', 05:32:52 INFO - 'HOME': '/home/cltbld', 05:32:52 INFO - 'LANG': 'en_US.UTF-8', 05:32:52 INFO - 'LANGUAGE': 'en_US:en', 05:32:52 INFO - 'LOGNAME': 'cltbld', 05:32:52 INFO - 'MAIL': '/var/mail/cltbld', 05:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:52 INFO - 'MOZ_NO_REMOTE': '1', 05:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:52 INFO - 'NO_EM_RESTART': '1', 05:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:52 INFO - 'SHELL': '/bin/bash', 05:32:52 INFO - 'SHLVL': '1', 05:32:52 INFO - 'TERM': 'linux', 05:32:52 INFO - 'TMOUT': '86400', 05:32:52 INFO - 'USER': 'cltbld', 05:32:52 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:52 INFO - '_': '/tools/buildbot/bin/python'} 05:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:52 INFO - Downloading/unpacking psutil>=0.7.1 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:32:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:32:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:54 INFO - Installing collected packages: psutil 05:32:54 INFO - Running setup.py install for psutil 05:32:54 INFO - building 'psutil._psutil_linux' extension 05:32:54 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:32:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:32:54 INFO - building 'psutil._psutil_posix' extension 05:32:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:32:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:54 INFO - Successfully installed psutil 05:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:32: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:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:32:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:32:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:32:54 INFO - Using env: {'DISPLAY': ':0', 05:32:54 INFO - 'HOME': '/home/cltbld', 05:32:54 INFO - 'LANG': 'en_US.UTF-8', 05:32:54 INFO - 'LANGUAGE': 'en_US:en', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MAIL': '/var/mail/cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SHLVL': '1', 05:32:54 INFO - 'TERM': 'linux', 05:32:54 INFO - 'TMOUT': '86400', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - '_': '/tools/buildbot/bin/python'} 05:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:32:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:32:56 INFO - Installing collected packages: mozsystemmonitor 05:32:56 INFO - Running setup.py install for mozsystemmonitor 05:32:56 INFO - Successfully installed mozsystemmonitor 05:32:56 INFO - Cleaning up... 05:32:56 INFO - Return code: 0 05:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:32:57 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:32:57 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:32:57 INFO - Using env: {'DISPLAY': ':0', 05:32:57 INFO - 'HOME': '/home/cltbld', 05:32:57 INFO - 'LANG': 'en_US.UTF-8', 05:32:57 INFO - 'LANGUAGE': 'en_US:en', 05:32:57 INFO - 'LOGNAME': 'cltbld', 05:32:57 INFO - 'MAIL': '/var/mail/cltbld', 05:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:57 INFO - 'MOZ_NO_REMOTE': '1', 05:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:57 INFO - 'NO_EM_RESTART': '1', 05:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:32:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:32:57 INFO - 'SHELL': '/bin/bash', 05:32:57 INFO - 'SHLVL': '1', 05:32:57 INFO - 'TERM': 'linux', 05:32:57 INFO - 'TMOUT': '86400', 05:32:57 INFO - 'USER': 'cltbld', 05:32:57 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:57 INFO - '_': '/tools/buildbot/bin/python'} 05:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:32:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:32:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:32:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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:32: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:32: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:32: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:32: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:32: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:32:59 INFO - Downloading docopt-0.6.1.tar.gz 05:32:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:32:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:59 INFO - Running setup.py install for blobuploader 05:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:32:59 INFO - Running setup.py install for requests 05:33:00 INFO - Running setup.py install for docopt 05:33:00 INFO - Successfully installed blobuploader requests docopt 05:33:00 INFO - Cleaning up... 05:33:00 INFO - Return code: 0 05:33:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:33:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:33:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:00 INFO - Using env: {'DISPLAY': ':0', 05:33:00 INFO - 'HOME': '/home/cltbld', 05:33:00 INFO - 'LANG': 'en_US.UTF-8', 05:33:00 INFO - 'LANGUAGE': 'en_US:en', 05:33:00 INFO - 'LOGNAME': 'cltbld', 05:33:00 INFO - 'MAIL': '/var/mail/cltbld', 05:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:00 INFO - 'MOZ_NO_REMOTE': '1', 05:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:00 INFO - 'NO_EM_RESTART': '1', 05:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:00 INFO - 'SHELL': '/bin/bash', 05:33:00 INFO - 'SHLVL': '1', 05:33:00 INFO - 'TERM': 'linux', 05:33:00 INFO - 'TMOUT': '86400', 05:33:00 INFO - 'USER': 'cltbld', 05:33:00 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:00 INFO - '_': '/tools/buildbot/bin/python'} 05:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:00 INFO - Running setup.py (path:/tmp/pip-FQ4IBN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:00 INFO - Running setup.py (path:/tmp/pip-Q62UWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:00 INFO - Running setup.py (path:/tmp/pip-tuAKgw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:00 INFO - Running setup.py (path:/tmp/pip-XpWKtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:00 INFO - Running setup.py (path:/tmp/pip-n0W6m9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:00 INFO - Running setup.py (path:/tmp/pip-L2fHga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:00 INFO - Running setup.py (path:/tmp/pip-WTgmRJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:00 INFO - Running setup.py (path:/tmp/pip-Dy9_eV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:00 INFO - Running setup.py (path:/tmp/pip-zOJjnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:01 INFO - Running setup.py (path:/tmp/pip-lSuETC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:01 INFO - Running setup.py (path:/tmp/pip-kE5mS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:01 INFO - Running setup.py (path:/tmp/pip-ZF7T3X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:01 INFO - Running setup.py (path:/tmp/pip-91Susu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:01 INFO - Running setup.py (path:/tmp/pip-ZwOgJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:01 INFO - Running setup.py (path:/tmp/pip-KPXJZ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:01 INFO - Running setup.py (path:/tmp/pip-956zW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:01 INFO - Running setup.py (path:/tmp/pip-gblj2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:01 INFO - Running setup.py install for manifestparser 05:33:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:33:01 INFO - Running setup.py install for mozcrash 05:33:01 INFO - Running setup.py install for mozdebug 05:33:01 INFO - Running setup.py install for mozdevice 05:33:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozfile 05:33:02 INFO - Running setup.py install for mozhttpd 05:33:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozinfo 05:33:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozInstall 05:33:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozleak 05:33:02 INFO - Running setup.py install for mozlog 05:33:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for moznetwork 05:33:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozprocess 05:33:02 INFO - Running setup.py install for mozprofile 05:33:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:33:02 INFO - Running setup.py install for mozrunner 05:33:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:33:03 INFO - Running setup.py install for mozscreenshot 05:33:03 INFO - Running setup.py install for moztest 05:33:03 INFO - Running setup.py install for mozversion 05:33:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:33:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:03 INFO - Cleaning up... 05:33:03 INFO - Return code: 0 05:33:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:33:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:33:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:03 INFO - Using env: {'DISPLAY': ':0', 05:33:03 INFO - 'HOME': '/home/cltbld', 05:33:03 INFO - 'LANG': 'en_US.UTF-8', 05:33:03 INFO - 'LANGUAGE': 'en_US:en', 05:33:03 INFO - 'LOGNAME': 'cltbld', 05:33:03 INFO - 'MAIL': '/var/mail/cltbld', 05:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:03 INFO - 'MOZ_NO_REMOTE': '1', 05:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:03 INFO - 'NO_EM_RESTART': '1', 05:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:03 INFO - 'SHELL': '/bin/bash', 05:33:03 INFO - 'SHLVL': '1', 05:33:03 INFO - 'TERM': 'linux', 05:33:03 INFO - 'TMOUT': '86400', 05:33:03 INFO - 'USER': 'cltbld', 05:33:03 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:03 INFO - '_': '/tools/buildbot/bin/python'} 05:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:03 INFO - Running setup.py (path:/tmp/pip-fgby6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:03 INFO - Running setup.py (path:/tmp/pip-7JAPaG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:03 INFO - Running setup.py (path:/tmp/pip-a8wEEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:03 INFO - Running setup.py (path:/tmp/pip-YXw8k3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:03 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:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:03 INFO - Running setup.py (path:/tmp/pip-TbApKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:03 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:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:04 INFO - Running setup.py (path:/tmp/pip-5dF5if-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:04 INFO - Running setup.py (path:/tmp/pip-oQTLTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:04 INFO - Running setup.py (path:/tmp/pip-oyG2IU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:04 INFO - Running setup.py (path:/tmp/pip-Dw1B8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:04 INFO - Running setup.py (path:/tmp/pip-bTslfX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:04 INFO - Running setup.py (path:/tmp/pip-dYWrLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:04 INFO - Running setup.py (path:/tmp/pip-8WuW4x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:04 INFO - Running setup.py (path:/tmp/pip-SJHpwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:04 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:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:04 INFO - Running setup.py (path:/tmp/pip-8AHPbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:04 INFO - Running setup.py (path:/tmp/pip-Nhjsly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:04 INFO - Running setup.py (path:/tmp/pip-LXzlg2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:33:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:04 INFO - Running setup.py (path:/tmp/pip-qHNXug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:33: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:33: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:33: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:33: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:33: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:33: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:33:06 INFO - Downloading blessings-1.5.1.tar.gz 05:33:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:33:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:06 INFO - Installing collected packages: blessings 05:33:06 INFO - Running setup.py install for blessings 05:33:06 INFO - Successfully installed blessings 05:33:06 INFO - Cleaning up... 05:33:06 INFO - Return code: 0 05:33:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:33:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:33:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:33:07 INFO - Reading from file tmpfile_stdout 05:33:07 INFO - Current package versions: 05:33:07 INFO - argparse == 1.2.1 05:33:07 INFO - blessings == 1.5.1 05:33:07 INFO - blobuploader == 1.2.4 05:33:07 INFO - docopt == 0.6.1 05:33:07 INFO - manifestparser == 1.1 05:33:07 INFO - mozInstall == 1.12 05:33:07 INFO - mozcrash == 0.16 05:33:07 INFO - mozdebug == 0.1 05:33:07 INFO - mozdevice == 0.47 05:33:07 INFO - mozfile == 1.2 05:33:07 INFO - mozhttpd == 0.7 05:33:07 INFO - mozinfo == 0.9 05:33:07 INFO - mozleak == 0.1 05:33:07 INFO - mozlog == 3.1 05:33:07 INFO - moznetwork == 0.27 05:33:07 INFO - mozprocess == 0.22 05:33:07 INFO - mozprofile == 0.27 05:33:07 INFO - mozrunner == 6.11 05:33:07 INFO - mozscreenshot == 0.1 05:33:07 INFO - mozsystemmonitor == 0.0 05:33:07 INFO - moztest == 0.7 05:33:07 INFO - mozversion == 1.4 05:33:07 INFO - psutil == 3.1.1 05:33:07 INFO - requests == 1.2.3 05:33:07 INFO - wsgiref == 0.1.2 05:33:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33: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:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:33:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:33:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:07 INFO - Using env: {'DISPLAY': ':0', 05:33:07 INFO - 'HOME': '/home/cltbld', 05:33:07 INFO - 'LANG': 'en_US.UTF-8', 05:33:07 INFO - 'LANGUAGE': 'en_US:en', 05:33:07 INFO - 'LOGNAME': 'cltbld', 05:33:07 INFO - 'MAIL': '/var/mail/cltbld', 05:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:07 INFO - 'MOZ_NO_REMOTE': '1', 05:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:07 INFO - 'NO_EM_RESTART': '1', 05:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:07 INFO - 'SHELL': '/bin/bash', 05:33:07 INFO - 'SHLVL': '1', 05:33:07 INFO - 'TERM': 'linux', 05:33:07 INFO - 'TMOUT': '86400', 05:33:07 INFO - 'USER': 'cltbld', 05:33:07 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:07 INFO - '_': '/tools/buildbot/bin/python'} 05:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:33:07 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:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:33:07 INFO - Cleaning up... 05:33:07 INFO - Return code: 0 05:33:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:33: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:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:33:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:33:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:33:07 INFO - Using env: {'DISPLAY': ':0', 05:33:07 INFO - 'HOME': '/home/cltbld', 05:33:07 INFO - 'LANG': 'en_US.UTF-8', 05:33:07 INFO - 'LANGUAGE': 'en_US:en', 05:33:07 INFO - 'LOGNAME': 'cltbld', 05:33:07 INFO - 'MAIL': '/var/mail/cltbld', 05:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:07 INFO - 'MOZ_NO_REMOTE': '1', 05:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:07 INFO - 'NO_EM_RESTART': '1', 05:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:07 INFO - 'SHELL': '/bin/bash', 05:33:07 INFO - 'SHLVL': '1', 05:33:07 INFO - 'TERM': 'linux', 05:33:07 INFO - 'TMOUT': '86400', 05:33:07 INFO - 'USER': 'cltbld', 05:33:07 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:07 INFO - '_': '/tools/buildbot/bin/python'} 05:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:07 INFO - Downloading/unpacking jsonschema 05:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:33:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:33:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:09 INFO - warning: no files found matching '*.txt' 05:33:09 INFO - no previously-included directories found matching 'build' 05:33:09 INFO - no previously-included directories found matching 'dist' 05:33:09 INFO - no previously-included directories found matching '.git*' 05:33:09 INFO - Installing collected packages: jsonschema, functools32 05:33:09 INFO - Running setup.py install for functools32 05:33:09 INFO - warning: no files found matching '*.txt' 05:33:09 INFO - no previously-included directories found matching 'build' 05:33:09 INFO - no previously-included directories found matching 'dist' 05:33:09 INFO - no previously-included directories found matching '.git*' 05:33:09 INFO - Successfully installed jsonschema functools32 05:33:09 INFO - Cleaning up... 05:33:09 INFO - Return code: 0 05:33:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6399b8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, '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': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', '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:33:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:33:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:33:09 INFO - Using env: {'DISPLAY': ':0', 05:33:09 INFO - 'HOME': '/home/cltbld', 05:33:09 INFO - 'LANG': 'en_US.UTF-8', 05:33:09 INFO - 'LANGUAGE': 'en_US:en', 05:33:09 INFO - 'LOGNAME': 'cltbld', 05:33:09 INFO - 'MAIL': '/var/mail/cltbld', 05:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:09 INFO - 'MOZ_NO_REMOTE': '1', 05:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:09 INFO - 'NO_EM_RESTART': '1', 05:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:09 INFO - 'SHELL': '/bin/bash', 05:33:09 INFO - 'SHLVL': '1', 05:33:09 INFO - 'TERM': 'linux', 05:33:09 INFO - 'TMOUT': '86400', 05:33:09 INFO - 'USER': 'cltbld', 05:33:09 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:09 INFO - '_': '/tools/buildbot/bin/python'} 05:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:09 INFO - Downloading/unpacking flake8 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:33:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:33:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 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:33:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:33:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:33:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:12 INFO - no previously-included directories found matching 'docs/_build' 05:33:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:33:12 INFO - Running setup.py install for pep8 05:33:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:12 INFO - no previously-included directories found matching 'docs/_build' 05:33:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:33:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:33:12 INFO - Cleaning up... 05:33:12 INFO - Return code: 0 05:33:12 INFO - Running post-action listener: _resource_record_post_action 05:33:12 INFO - Running post-action listener: _start_resource_monitoring 05:33:12 INFO - Starting resource monitoring. 05:33:12 INFO - ##### 05:33:12 INFO - ##### Running install step. 05:33:12 INFO - ##### 05:33:12 INFO - Running pre-action listener: _resource_record_pre_action 05:33:12 INFO - Running main action method: install 05:33:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:33:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:33:12 INFO - Reading from file tmpfile_stdout 05:33:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:33:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:33:12 INFO - Reading from file tmpfile_stdout 05:33:12 INFO - Output received: 05:33:12 INFO - Usage: mozinstall [options] installer 05:33:12 INFO - Options: 05:33:12 INFO - -h, --help show this help message and exit 05:33:12 INFO - -d DEST, --destination=DEST 05:33:12 INFO - Directory to install application into. [default: 05:33:12 INFO - "/builds/slave/test-pgo"] 05:33:12 INFO - --app=APP Application being installed. [default: firefox] 05:33:12 INFO - mkdir: /builds/slave/test-pgo/build/application 05:33:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:33:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:33:28 INFO - Reading from file tmpfile_stdout 05:33:28 INFO - Output received: 05:33:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:33:28 INFO - Running post-action listener: _resource_record_post_action 05:33:28 INFO - ##### 05:33:28 INFO - ##### Running run-tests step. 05:33:28 INFO - ##### 05:33:28 INFO - Running pre-action listener: _resource_record_pre_action 05:33:28 INFO - Running main action method: run_tests 05:33:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:33:28 INFO - Python 2.7.3 05:33:28 INFO - Return code: 0 05:33:28 INFO - grabbing minidump binary from tooltool 05:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ed350>, '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 0x20ee250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ee6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:33:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:33:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:33:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:28 INFO - Return code: 0 05:33:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:33:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:33:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:33:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:33:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:33:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:33:29 INFO - Return code: 0 05:33:29 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/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:33:29 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/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 05:33:29 INFO - Using env: {'DISPLAY': ':0', 05:33:29 INFO - 'HOME': '/home/cltbld', 05:33:29 INFO - 'LANG': 'en_US.UTF-8', 05:33:29 INFO - 'LANGUAGE': 'en_US:en', 05:33:29 INFO - 'LOGNAME': 'cltbld', 05:33:29 INFO - 'MAIL': '/var/mail/cltbld', 05:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:29 INFO - 'MOZ_NO_REMOTE': '1', 05:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:29 INFO - 'NO_EM_RESTART': '1', 05:33:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:33:29 INFO - 'SHELL': '/bin/bash', 05:33:29 INFO - 'SHLVL': '1', 05:33:29 INFO - 'TERM': 'linux', 05:33:29 INFO - 'TMOUT': '86400', 05:33:29 INFO - 'USER': 'cltbld', 05:33:29 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286', 05:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:29 INFO - '_': '/tools/buildbot/bin/python'} 05:33:29 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/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 05:33:29 INFO - mozversion INFO | application_buildid: 20151220030223 05:33:29 INFO - mozversion INFO | application_changeset: 388bdc46ba51ee31da8b8abe977e0ca38d117434 05:33:29 INFO - mozversion INFO | application_display_name: Nightly 05:33:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:29 INFO - mozversion INFO | application_name: Firefox 05:33:29 INFO - mozversion INFO | application_remotingname: firefox 05:33:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:33:29 INFO - mozversion INFO | application_vendor: Mozilla 05:33:29 INFO - mozversion INFO | application_version: 46.0a1 05:33:29 INFO - mozversion INFO | platform_buildid: 20151220030223 05:33:29 INFO - mozversion INFO | platform_changeset: 388bdc46ba51ee31da8b8abe977e0ca38d117434 05:33:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:33:29 INFO - mozversion INFO | platform_version: 46.0a1 05:33:29 INFO - 2015-12-20 05:33:29,626 DEBUG : using testdate: 1450618409 05:33:29 INFO - 2015-12-20 05:33:29,626 DEBUG : actual date: 1450618409 05:33:29 INFO - 2015-12-20 05:33:29,744 INFO : starting webserver on 'localhost:56234' 05:33:29 INFO - 2015-12-20 05:33:29,745 INFO : Starting test suite talos-linux64-ix-053 05:33:29 INFO - 2015-12-20 05:33:29,745 INFO : Starting test dromaeo_css 05:33:29 INFO - 2015-12-20 05:33:29,745 DEBUG : operating with platform_type : linux_ 05:33:29 INFO - 2015-12-20 05:33:29,746 INFO : Initialising browser for dromaeo_css test... 05:33:29 INFO - 2015-12-20 05:33:29,761 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRRjrAr/profile http://localhost:56234/getInfo.html 05:33:33 INFO - 2015-12-20 05:33:33,657 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:33:33 INFO - 2015-12-20 05:33:33,657 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:33:33 INFO - 2015-12-20 05:33:33,657 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:33:33 INFO - 2015-12-20 05:33:33,657 DEBUG : BROWSER_OUTPUT: __metrics 05:33:33 INFO - 2015-12-20 05:33:33,758 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:33:33 INFO - 2015-12-20 05:33:33,802 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:33:33 ERROR - 2015-12-20 05:33:33,818 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:33:34 INFO - 2015-12-20 05:33:34,731 INFO : Browser initialized. 05:33:34 INFO - 2015-12-20 05:33:34,732 INFO : Running cycle 1/1 for dromaeo_css test... 05:33:34 INFO - 2015-12-20 05:33:34,732 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRRjrAr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:33:46 INFO - 2015-12-20 05:33:46,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 150634496 05:33:46 INFO - 2015-12-20 05:33:46,539 DEBUG : BROWSER_OUTPUT: 05:34:38 INFO - 2015-12-20 05:34:38,129 DEBUG : BROWSER_OUTPUT: 1450618478128 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:36:46 INFO - 2015-12-20 05:36:46,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56234/tests/dromaeo/cssquery-ext.html) 05:36:47 INFO - 2015-12-20 05:36:47,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 253853696 05:36:47 INFO - 2015-12-20 05:36:47,567 DEBUG : BROWSER_OUTPUT: 05:39:49 INFO - 2015-12-20 05:39:49,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-ext.html (next: http://localhost:56234/tests/dromaeo/cssquery-jquery.html) 05:39:50 INFO - 2015-12-20 05:39:50,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 232689664 05:39:50 INFO - 2015-12-20 05:39:50,541 DEBUG : BROWSER_OUTPUT: 05:42:52 INFO - 2015-12-20 05:42:52,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56234/tests/dromaeo/cssquery-mootools.html) 05:42:52 INFO - 2015-12-20 05:42:52,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 228700160 05:42:52 INFO - 2015-12-20 05:42:52,998 DEBUG : BROWSER_OUTPUT: 05:45:54 INFO - 2015-12-20 05:45:54,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56234/tests/dromaeo/cssquery-prototype.html) 05:45:55 INFO - 2015-12-20 05:45:55,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 216453120 05:45:55 INFO - 2015-12-20 05:45:55,458 DEBUG : BROWSER_OUTPUT: 05:48:57 INFO - 2015-12-20 05:48:57,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56234/tests/dromaeo/cssquery-yui.html) 05:48:58 INFO - 2015-12-20 05:48:58,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 215048192 05:48:58 INFO - 2015-12-20 05:48:58,460 DEBUG : BROWSER_OUTPUT: 05:52:00 INFO - 2015-12-20 05:52:00,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/dromaeo/cssquery-yui.html (next: http://localhost:56234/tests/dromaeo/cssquery-dojo.html) 05:52:01 INFO - 2015-12-20 05:52:01,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 258109440 05:52:01 INFO - 2015-12-20 05:52:01,134 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,136 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:52:01 INFO - 2015-12-20 05:52:01,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:52:01 INFO - 2015-12-20 05:52:01,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:52:01 INFO - 2015-12-20 05:52:01,136 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:52:01 INFO - 2015-12-20 05:52:01,140 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3078.1381213260283;3194.1056504178837;3194.552762613236;3204.791688540244;3217.581714377129;5064.037832811763;5201.0898092833795;5221.164613661815;5269.973650131748;5309.0709125903;5191.6365854390115;5272.340957380327;5276.287701160342;5325.0148722486365;5325.281087053257;4831;4863.14894893394;4868.269759536062;4871.707697538159;4927.581155601778;4900.926486102711;4932.679375840559;4934.777934992916;4958.9752051239875;4970.577500912426;4714.104320179155;4767.165745994437;4826.251930950708;4873.122837889178;4886.902261954759;4870.6103511718975;4876;4902.166631672624;4915.48387419323;4918.385201849769;4850.636202284807;4855.223164293731;4857.6599638025355;4865.2945322928335;4891.975540122312;4946.431160416562;5050.116229659795;5080.263361812516;5143.974280128613;5209.661372010807;5695.943040569583;5700.800471983503;5710.971445142748;5711.543076553866;5720.342160651537;5727.055035919068;5727.713614319267;5730.627509211888;5731.083026715705;5733.942660573382;5177.637565370425;5278.604104692164;5291.99452104099;5403.2705584746345;5444.40111587725;5655.349634791969;5672.517835983905;5682.772689092472;5688.943110568925;5700.714964251771;5456.7544460499375;5506.834794956158;5507.228987941691;5513.2005859150195;5533.557315414757;5585.050541407971;5600.103983362643;5634.690092044895;5722.685252311079;5770.394108618619;5754.568407369464;5758.539316854642;5759.107338362477;5760.452756988079;5765.04876695349;5457.20870473787;5700.771969121189;5706.42935706426;5751.051076572402;5758.452946970031;4314.80583373749;4319.460067491564;4337.587929146726;4372.453443319585;4445.955540444619;3968.027833180889;3971.860984865516;3986.2226865761477;4006.1186538961383;4018.3570628699267;5400.324959380077;5407.864803379947;5408.323959505062;5408.594355423359;5415.593830462731;5643.915341269884;5671.347795003545;5778.451047150514;5784.334801497882;5784.479396854304;5401.189821526724;5405.189221616711;5426.782928682887;5433.8369848904595;5454.809081682122;5024.949750502521;5025.221090730943;5026.346574945233;5027.4469808321055;5068.721220332844;5621.690807005572;5807.186993820868;5814.563907706939;5817.76728930838;5823.82528524145;5730.054541000855;5731.713414329351;5781.739821707949;5816.069428891357;5848.941510584839;5848.473637372657;5856.531477481876;5858.238429004202;5862.882742345215;5863.648181108976;5654.46282603152;5656.013875874758;5693.857653558694;5710.4004079572705;5716.971415142898;5546;5673.574481913955;5693.715314234355;5787.421257874179;5803.47768700819;5541.418151094238;5542.140968149944;5549.195366671891;5549.361823390201;5591.916121258266;5514.696691681996;5529.336479622471;5534.584906131976;5535.142052981794;5544.972275138599;5359.14253719403;5419.295491586068;5437.102878025082;5478.698671572943;5501.944980550144;5563.860903477445;5571.3592936811165;5590.133529302964;5594.440555944373;5703.372629010889;5461.863453413696;5464.398916119144;5470.671759694431;5471.316085489314;5490.203920431595 05:52:01 INFO - 2015-12-20 05:52:01,141 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.1032741958749;579.3279795437293;596.221930380853;601.7562887030751;603.3272900715704;30022.24944376389;38809.22381552371;38997.02507437319;39060.21879562414;39084.80457597708;41881;42092;42283.36574951378;42352.152956940845;42374.78812605933;7356.521826081314;7484.513506622052;8617.827643447128;8797.824043519158;8800.559972001374;10217.438040907784;10431.791364172712;10439.634612788554;10442.112420444271;10442.791144177112;10266.897331026707;10316.690499285034;10365.585376584928;10378;10391.896081039205;7750.612469376509;7932.127465978738;7939.126696063428;10259.846102308435;10331.328463649914;10123;10258.230632702576;10264.127549158331;10266.948665256627;10269.743256418575;39138.412923806165;39566;39573.80213098916;39585.20829583421;39621.40567891484;2716.375233696261;2765.092086460336;2799.384135490189;2859.4995875721665;3369.7304215662934;28592.571111433346;28833;29043;29113.126606201848;29529;3458.6714262145056;3480.9651903480894;3523.6476352364557;3588.802615856153;3647.6170002149925;252046.47953520413;252839;254253;254591;255058.99999999814;57740.71129644409;58672.706636467396;59601.40398596045;59794.40205597975;60453.39546604566;58239.417605824245;59049.70475147597;59244;59501.404985949586;59540.70229648824;15080.849191508163;15225.238738063052;15228.619284517976;15319.61700957485;15342.923285383726;11940.641780746419;12023.699407514881;12028.218165819193;12146.392680365947;12250.387480626112;19825.900870495843;20072.69890951637;20102.798972010092;20191.4952126198;20235.696464553042;7798.961005194938;7963.761087167394;8020.598970051474;8029.317508011768;8187.345012398994;851.3572252949108;873.4015854678764;977.2182254196756;1040.2302296300834;1055.3087727538475;27972.44055118886;28256.43487130246;28293.85853070763;28639.427211455655;28644;963.8554216867526;1009.1976878381704;1048.6696690542608;1106.7288514313884;1136.1251836086167;14765.852341476448;14963.70072598542;14981.550553483414;15168.772468412983;15230.314635841414;294862;298151;300821;301430;301585;52469;53274.20088698673;53275.20087198695;53289.2006619901;53305.46694533082;1262.4319056424645;1286.8005459153846;1293.1465232946211;1295.371744703818;1316.2168509736691;23829.213394017384;27432.17703468899;28179.57730634083;28212;28348.216512846095;37759.43360849535;38137.61862381452;38147.237055258185;42840.64491938508;42935.78532107319;196417;196516;197085;197543;197747;27632.44735105327;28042.579361310003;30369.544456832722;31465.37069258648;31514.212144696565;37654.811725941196;37680.623193767715;38402.42396364001;38639;38677;34115.31769364649;34457.13857153491;35073.82463087668;35153.25908925816;35475.29049418945;34425.311493769485;35152.47271290881;35208.823955880056;35245.82377088201;40512.392314114724;35243.82378088093;35621.82189089038;35838.64161358353;36040.819795900854;36131;30971.69028309688;32287.677123228466;32892;33048.33903321968;33060.834695826365;24520.264392067555;25180.24459266225;26312.8684356577;27679.30801729973;28357.149285521467 05:52:01 INFO - 2015-12-20 05:52:01,143 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.2140986305469;356.65760869565213;357.4995006990213;359.61880406768813;360.8268031344954;14125.646858828535;14351.28243587819;16372.754408683864;17139.82860171398;18206.08969551522;14057.297135143253;15341.616459588487;15376.23118844059;15599;17506.824931750678;5305.814296499633;5436.891262174774;5437.374701909272;5439.048166570854;5440.972795136019;5241.082810508165;5377.892442151155;5382.165764306519;5383.43473935237;5386.78452861885;5329.094054010808;5329.280547126146;5341.03861304965;5346.759395827197;5350.678959262437;5245.108331583621;5373.650712703662;5382.811601593945;5384.946150538503;5390.460953904618;4826.782794774209;4828.855134345975;4832.806687732486;4835.637327200438;4836.661433699607;18828.24687012518;19435.416937491897;20813.063412146337;21236;21281.57436851254;1858.656148612511;1958.5005823514912;2008.658528050235;2049.077914938269;2178.1069761397753;8518.74443766688;8951.23914467271;9077.546122693839;9382.577783999737;12561.246325220516;1729.2218501674172;1746.9301227950866;1762.2246211666825;1799.379214171109;1827.725841123842;50034.49965500371;50045.499545004444;50814.7459262705;56722.43277567254;63042.68478657577;8980.820383592421;9935.254855885838;9941.950290248502;10050.69847904564;10119.494025298705;13125.212487250796;13174;13196.868031319756;13217.405216765268;13221.140625859289;7050.541714788625;7052;7108.431325493948;7164.713411463587;7283.890741638879;6687.1975362956755;6697.732090716414;6925.722971081101;7024.824379390454;7105.538140020882;4179.6029377209115;4263.445752052214;4331.610155086058;4459;4490.797914093809;1836.97244541332;1842.4472658202753;1868.215349553191;1879.9906000470185;1894.6116046210493;793.4961299574811;951.5052172870069;960.1023043454253;981.9395053342373;1033.3748082410184;14653.560393188221;16544.917275413547;16550;16876.240569174417;17103.14484275781;857.8112815180775;866.7313132928812;931.1340453378423;948.0756262643868;979.4368238262884;8173.509589424653;9364.62541498346;9463.858042129235;9670.56482458291;9747.171490423394;486537;494458;496437;498540;498619;84021;84274;84446.57776711076;85680.57159714162;86176.56911715401;1064.7018834726289;1075.0593230922943;1076.1175835814556;1077.9892201078046;1095.6329629574022;15480.148591827558;15664.530064098095;16023.439179628656;16098.67802643964;16235.431759888348;35289.29421411609;35533.64466355303;36124.81937590295;36831;36869.26261474809;47551.5244847561;47578.76210618925;48160.518394815605;49403;52361.47638523566;8952.641894324153;9817.509124543887;9859.753506162404;9865.901340986786;9950.35322704022;11222.102231821598;11242.269252498561;11311.264767790068;11319.547218111184;11331.490082946122;13500.729985400434;13943.790843137564;14048.648783780487;14293.499727509487;14443.133411995314;14159.64600884986;14216.644583885485;14276.500322488662;14297;14300.570982870531;14469.421223150955;14651.633709157357;14802.703945921237;14886.702265954837;15405.845941540441;7977.242161994601;9245.72262832116;9778.41329520231;9787.608495660093;9788.80422391534;9775.413475191512;9856.753581160528;12092.516299348279;14442.783358249424;14826.110433374031 05:52:01 INFO - 2015-12-20 05:52:01,144 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1510.3580978084312;1633.1507616039657;1703.3782669325692;1705.7782488276523;1742.6340468501614;6514.381133792294;6858.588484690922;6865.073215115958;6870.38166565009;6870.450363970883;6166.630002199871;6249.375062493748;6763.729450821961;6996.650167491631;7026.613536255504;2066.4110728442397;2067.2867860588112;2069.8447616428753;2092.204962114394;2094.0890712540017;1884.6701827180257;2040.714299997994;2064.9483762905897;2069.3481553310735;2088.2064815370136;1869.9813001870011;1979.4655443030374;2059.1763294682096;2062.9174833006664;2064.834813214939;2032.1668116072487;2068.214078650111;2073.5749171419825;2074.7406574178226;2104.105755054096;2090.686397040456;2109.504266497372;2112.26070875194;2113.0596884386455;2114.38682781993;6978.79063628092;7084.14990201174;7093;7103.644817759143;7108.253633368474;4081.7346872453195;4167.249895018896;4201.6008479194425;4204.264253755611;4204.726692764961;2819.6183869903803;2864.5273529867545;2869.880746508863;2874.5257032589598;2882.524383476724;919.6183583812709;933.9252859771202;957.2676902169845;972.3096601413005;992.6277645882794;9477.90522094784;9494.145526902612;9498.9525052375;9501.2874034447;9508.47703376314;3717.4052151655605;3718.1448266898765;3740.457633643161;3752.887413377603;3775.8300876460626;8200.671973121009;8203.58982050895;8209.220124088202;8218.589070546448;8229.629666664894;4250.3199488081755;4254.829806807693;4261.21167583998;4261.786910654455;4263.126059157928;3887.5918028607157;3895.454636350913;3899.66852817508;3902.687784977195;3903.5510916244993;3295.4727243641382;3298.224917144469;3314.950275745866;3356.6643335666727;3357.496375543688;967.7145242153582;983.233078199006;1031.9432431216355;1033.4316126130598;1038.9428581428094;924.473050361301;924.8751418558543;990.4997976022063;1048.7430579507916;1251.7809383357876;6402.519811014193;6441.1626488556185;6450.032495125769;6451.870962580722;6452.290248072708;1081.5187241677536;1083.6207327435334;1095.8191898336845;1120.7310245541012;1123.5225029362489;5169.172932330809;5182.844514664566;5210.869728256824;5231.372235331708;5235.424103348629;8189.344852411793;8197.180281971874;8322.417430779908;8353.95823020881;8391.95804020976;8144.511329320259;8196.385271104691;8280.254777069973;8311.210435008665;8315.750527484186;6595.538312318092;6624.900626490607;6650.600963942082;6707.5975441473665;6711.395974362331;6286.591371560834;6465.2564955030775;6489.805305840832;6510.837229069311;6768.763093291711;7157.892631610634;7421.777346679392;7471.813204669927;7529.736459223901;7539.811504712426;7250.673719682733;7376.7049318026675;7399.445041622008;7509.6245187739305;7511.9624401877645;6220.533459990609;6345.555811093363;6401.583897046677;6406.743730250924;6407.871842563216;6872.518923675495;6969.059177011039;6969.30306969299;6970.128733908262;6972.860542789014;6475.093486911742;6562.179727534059;6569;6653.800385988428;6667.19993600771;5709.200711900255;5779.855503612275;6063.272407311151;6186.659733714689;6215.502759779117;6366.076918846834;6379.681015949277;6414.550981431255;6422.775202867877;6426.839329016812;5900.498457630978;5917.37867523921;5920.37836027211;5927.229460170151;5936.881262374642;5915.881682366415;5916;5936.198613187337;5943.58394912352;5955 05:52:01 INFO - 2015-12-20 05:52:01,146 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.4168413487454;333.9532465454837;341.07228338918134;344.2924789557458;348.0185875830157;5937.732802023908;6000.069989151683;6000.399960003997;6033.668148251844;6037.698115094249;5857.531397488201;5905.143754155645;5909.556783241253;5916.787058652976;5919.37846526115;4617.261238201889;4625.814967401317;4626.121037002967;4627.097715945392;4629.213033784248;4451.777411129447;4591.47198072221;4607.58531732144;4614;4614.353990441324;4562.041971186055;4562.064776720781;4563.543645635426;4567.65742569307;4567.725936443808;4285.5928686774705;4353.73877567347;4447.155040542287;4566.10960862632;4570.451545814491;3953.525576930758;3980.223856348013;3981.98009009956;3987.920241595181;3993.5806740292433;5671.319441666985;5682.6306290091425;5683.460071293221;5691.715414229313;5702.885942281173;4935.210366341368;5057.291979122889;5148.819791307286;5252.107141785906;5290.4974027467715;6297.149884765544;6311.621302721851;6316.905246421307;6318.74725010999;6332.240131184241;4385.298352263654;4407.845725399596;4410.294352903552;4417.072414792898;4417.226985277595;6370.458511026568;6463.385978332051;6509.837254068639;6524.543281970264;6527.804165875032;4470.195364834296;4480.32795080734;4483.977580112144;4493.056458143827;4493.505714371417;4541.613962813131;4542.659300552472;4544.6818722689095;4545.068261006486;4545.477270113979;5267.499587539178;5269.789208431696;5270.235815806686;5274.156135018378;5277.076511610453;6240.344763799826;6359.8092057238355;6369.299377068519;6372.553921225563;6380.330065343072;1583.580351206908;1621.0273835698722;1621.4000819696787;1621.6918785430967;1622.7484739865104;1031.28841099641;1050.5272627317738;1064.6646306413454;1075.8386242063752;1109.4397329348628;6121.908171377433;6121.938780612226;6125.816225513153;6128.4790792783115;6131.356207598227;6547.770828021092;6574.276829548746;6596.373344532261;6601;6611.140551728245;5987.1318658794235;6133.815985520441;6133.926562851572;6135.049067394561;6138.294096178996;3561.5726112866105;3581.7492775505984;3583.51284217047;3583.982080089635;3587.7488575799966;6668.199816022108;6682.899756503656;6683.565568238049;6684.665766711645;6689.832754181087;6570.178727659043;6624.304448032984;6704.497162712816;6710.396064354231;6718.328167183243;6507.9023814642815;6527.34726527353;6545.476361891037;6686.197656281277;6761.898571521431;6600.2409722882485;6628.5028622852515;6631.834204144935;6648.368405001517;6655.267920528835;6321.146645202839;6511.2512061113575;6518.054882041983;6520.087187793618;6536.411722944958;6699.330066993261;6700.597964122168;6705.09481220029;6709.36261055199;6712.530122891546;4552.954470455253;4553.749543774991;4557.453105627346;4558.179527685049;4561.703489273186;6431.196100487439;6588.176477940257;6591.703373348115;6595.703193356215;6606.141201643755;6419.55063145594;6426.4216220540375;6428.003659432796;6433.388828061326;6439.227292724903;6432.13166222554;6432.38892305249;6433.292337842927;6434.292227855026;6439.195100612424;6182.196314479089;6305.337939516285;6315.652639104894;6323.683815809283;6348.777792777415;6509.316521765336;6509.641969691713;6516.380943810331;6519.4132528072705;6521.347865213441;6336.398042185985;6336.651484168415;6339.778107766206;6341.904871427025;6345.650989195638 05:52:01 INFO - 2015-12-20 05:52:01,149 DEBUG : BROWSER_OUTPUT: |5;yui.html;751.8834580640003;816.3754727633361;823.5882058970515;826.1862065865123;828.8135169586843;12221.511139554419;12471.750564988695;12488.937555312223;12512.311822849739;12534.874651253485;12103.455344509497;12362.134650574464;12376.876231237686;12537.31044792536;13489.190648561093;803.4536515169697;812.8821320908464;813.3655748516137;814.5235037503068;814.9307308878753;692.7540723043322;700.3976580141075;806.9435139540235;814.6130587970725;834.2616784146044;857.1771099744253;858.7853036740814;865.9134086591322;868.8088620503479;869.5043825019741;716.8422946951662;860.8579584368572;861.1001503428901;861.3152543727751;862.1593945902727;532.51541097601;617.1729881958153;627.4227710506345;627.4980015987192;628.3936001758279;12915.547955821501;13287.601371958857;13289.86710132896;13291.3354332283;13318.667033324147;11272.774544509064;11658.358790266531;11685.649430517098;11889.464974076187;12190.39048047594;9734.659286924923;9768.853467197998;9780.853287200698;9857.211423086135;10042.246831487595;3555.9111022224392;3609.693176080036;3652;3675.4303083022173;3681.2821499807546;49025.264621030714;49124.50875491235;49417.50582494165;49432.50567494315;49578.7521062396;9590.952045239868;9618;9696.61213551464;9742.269329800294;9835.114839664464;17503;17572.03353815527;17576.56058598545;17630;17632.795900512436;7153.284671532805;7287.198408175096;7306.159791623925;7334.48658593904;7400.147266612301;4179.623833854967;4196.727212731163;4241.554636763157;4296.634786043159;4308.806103725277;2853.2724155340256;2892.190186747714;2893.7106289370895;2897.058456001808;2898.3623602807347;517.1002455727008;518.4530320511897;526.2369564132024;541.3449725831709;547.5127136848208;590.4803772680015;631.207834168116;645.2482857470993;652.2727159217438;711.2425267090532;8540.658373665108;8753.737387878375;8973.551322433852;9056.094390560891;9160.404573702688;551.1168278625655;598.2103623217398;602.9638221706712;661.1240106858431;670.4267850987336;3743.3823419136083;3977.721559490808;4047.6178651423147;4050.8177132029127;4056.9594304057173;56506;57428.71285643629;57737.71131144317;58006.41993580094;58217.70891145517;51155.744221278655;51221.487785122416;51254;51366.48633513617;51766.48233517692;46582;47265.5273447268;47273.290900636515;47332.29001564979;48159.518404815506;7968.123506414406;7977;8128.227818357246;8179.182081791773;8278.296344810758;35941.64058359383;36259;36477.27045459129;36580.81709591435;37247.44128838124;43019.56980430281;44607;44853.55146448624;45507.54492455033;45818.541814581426;9879.110880020833;9918.504074796376;10281.331713438603;10545.683629491128;10617.787644247226;11462.369569673749;11706.180567360203;11726.765464690829;11735.295882247092;11791.705207369885;10439.582416703246;10470.31942923738;10612.893871061191;10684.358938463716;10764.46177691128;10208.438535880301;10294.845577316197;10500.579976801147;10695.786084278427;10939.28894621847;10703.625373111903;10768.084712799186;10824.24230303871;10880.129589632968;11045.116390688887;9559.94840567551;9571.904280957102;9626.614935402506;9888.847444983216;10170.745731356776;8482.682188963268;9013.414128081653;9403.811923761623;9564.234861211226;9755.365901216399 05:52:01 INFO - 2015-12-20 05:52:01,149 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:52:01 INFO - 2015-12-20 05:52:01,149 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:52:01 INFO - 2015-12-20 05:52:01,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,864 05:52:01 INFO - 2015-12-20 05:52:01,149 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: __startTimestamp1450619521135__endTimestamp 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5288.87 Median:5470.67 stddev:573.53 (10.5%) stddev-sans-first:548.44 05:52:01 INFO - 2015-12-20 05:52:01,150 DEBUG : BROWSER_OUTPUT: Values: 3078.1 3194.1 3194.6 3204.8 3217.6 5064.0 5201.1 5221.2 5270.0 5309.1 5191.6 5272.3 5276.3 5325.0 5325.3 4831.0 4863.1 4868.3 4871.7 4927.6 4900.9 4932.7 4934.8 4959.0 4970.6 4714.1 4767.2 4826.3 4873.1 4886.9 4870.6 4876.0 4902.2 4915.5 4918.4 4850.6 4855.2 4857.7 4865.3 4892.0 4946.4 5050.1 5080.3 5144.0 5209.7 5695.9 5700.8 5711.0 5711.5 5720.3 5727.1 5727.7 5730.6 5731.1 5733.9 5177.6 5278.6 5292.0 5403.3 5444.4 5655.3 5672.5 5682.8 5688.9 5700.7 5456.8 5506.8 5507.2 5513.2 5533.6 5585.1 5600.1 5634.7 5722.7 5770.4 5754.6 5758.5 5759.1 5760.5 5765.0 5457.2 5700.8 5706.4 5751.1 5758.5 4314.8 4319.5 4337.6 4372.5 4446.0 3968.0 3971.9 3986.2 4006.1 4018.4 5400.3 5407.9 5408.3 5408.6 5415.6 5643.9 5671.3 5778.5 5784.3 5784.5 5401.2 5405.2 5426.8 5433.8 5454.8 5024.9 5025.2 5026.3 5027.4 5068.7 5621.7 5807.2 5814.6 5817.8 5823.8 5730.1 5731.7 5781.7 5816.1 5848.9 5848.5 5856.5 5858.2 5862.9 5863.6 5654.5 5656.0 5693.9 5710.4 5717.0 5546.0 5673.6 5693.7 5787.4 5803.5 5541.4 5542.1 5549.2 5549.4 5591.9 5514.7 5529.3 5534.6 5535.1 5545.0 5359.1 5419.3 5437.1 5478.7 5501.9 5563.9 5571.4 5590.1 5594.4 5703.4 5461.9 5464.4 5470.7 5471.3 5490.2 05:52:01 INFO - 2015-12-20 05:52:01,151 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,151 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42431.03 Median:30670.62 stddev:66027.10 (215.3%) stddev-sans-first:66137.44 05:52:01 INFO - 2015-12-20 05:52:01,151 DEBUG : BROWSER_OUTPUT: Values: 548.1 579.3 596.2 601.8 603.3 30022.2 38809.2 38997.0 39060.2 39084.8 41881.0 42092.0 42283.4 42352.2 42374.8 7356.5 7484.5 8617.8 8797.8 8800.6 10217.4 10431.8 10439.6 10442.1 10442.8 10266.9 10316.7 10365.6 10378.0 10391.9 7750.6 7932.1 7939.1 10259.8 10331.3 10123.0 10258.2 10264.1 10266.9 10269.7 39138.4 39566.0 39573.8 39585.2 39621.4 2716.4 2765.1 2799.4 2859.5 3369.7 28592.6 28833.0 29043.0 29113.1 29529.0 3458.7 3481.0 3523.6 3588.8 3647.6 252046.5 252839.0 254253.0 254591.0 255059.0 57740.7 58672.7 59601.4 59794.4 60453.4 58239.4 59049.7 59244.0 59501.4 59540.7 15080.8 15225.2 15228.6 15319.6 15342.9 11940.6 12023.7 12028.2 12146.4 12250.4 19825.9 20072.7 20102.8 20191.5 20235.7 7799.0 7963.8 8020.6 8029.3 8187.3 851.4 873.4 977.2 1040.2 1055.3 27972.4 28256.4 28293.9 28639.4 28644.0 963.9 1009.2 1048.7 1106.7 1136.1 14765.9 14963.7 14981.6 15168.8 15230.3 294862.0 298151.0 300821.0 301430.0 301585.0 52469.0 53274.2 53275.2 53289.2 53305.5 1262.4 1286.8 1293.1 1295.4 1316.2 23829.2 27432.2 28179.6 28212.0 28348.2 37759.4 38137.6 38147.2 42840.6 42935.8 196417.0 196516.0 197085.0 197543.0 197747.0 27632.4 28042.6 30369.5 31465.4 31514.2 37654.8 37680.6 38402.4 38639.0 38677.0 34115.3 34457.1 35073.8 35153.3 35475.3 34425.3 35152.5 35208.8 35245.8 40512.4 35243.8 35621.8 35838.6 36040.8 36131.0 30971.7 32287.7 32892.0 33048.3 33060.8 24520.3 25180.2 26312.9 27679.3 28357.1 05:52:01 INFO - 2015-12-20 05:52:01,151 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,151 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27347.12 Median:4474.90 stddev:81048.31 (1811.2%) stddev-sans-first:81250.33 05:52:01 INFO - 2015-12-20 05:52:01,152 DEBUG : BROWSER_OUTPUT: Values: 353.2 356.7 357.5 359.6 360.8 14125.6 14351.3 16372.8 17139.8 18206.1 14057.3 15341.6 15376.2 15599.0 17506.8 5305.8 5436.9 5437.4 5439.0 5441.0 5241.1 5377.9 5382.2 5383.4 5386.8 5329.1 5329.3 5341.0 5346.8 5350.7 5245.1 5373.7 5382.8 5384.9 5390.5 4826.8 4828.9 4832.8 4835.6 4836.7 18828.2 19435.4 20813.1 21236.0 21281.6 1858.7 1958.5 2008.7 2049.1 2178.1 8518.7 8951.2 9077.5 9382.6 12561.2 1729.2 1746.9 1762.2 1799.4 1827.7 50034.5 50045.5 50814.7 56722.4 63042.7 8980.8 9935.3 9942.0 10050.7 10119.5 13125.2 13174.0 13196.9 13217.4 13221.1 7050.5 7052.0 7108.4 7164.7 7283.9 6687.2 6697.7 6925.7 7024.8 7105.5 4179.6 4263.4 4331.6 4459.0 4490.8 1837.0 1842.4 1868.2 1880.0 1894.6 793.5 951.5 960.1 981.9 1033.4 14653.6 16544.9 16550.0 16876.2 17103.1 857.8 866.7 931.1 948.1 979.4 8173.5 9364.6 9463.9 9670.6 9747.2 486537.0 494458.0 496437.0 498540.0 498619.0 84021.0 84274.0 84446.6 85680.6 86176.6 1064.7 1075.1 1076.1 1078.0 1095.6 15480.1 15664.5 16023.4 16098.7 16235.4 35289.3 35533.6 36124.8 36831.0 36869.3 47551.5 47578.8 48160.5 49403.0 52361.5 8952.6 9817.5 9859.8 9865.9 9950.4 11222.1 11242.3 11311.3 11319.5 11331.5 13500.7 13943.8 14048.6 14293.5 14443.1 14159.6 14216.6 14276.5 14297.0 14300.6 14469.4 14651.6 14802.7 14886.7 15405.8 7977.2 9245.7 9778.4 9787.6 9788.8 9775.4 9856.8 12092.5 14442.8 14826.1 05:52:01 INFO - 2015-12-20 05:52:01,152 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4912.32 Median:6218.02 stddev:2495.29 (40.1%) stddev-sans-first:2489.19 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: Values: 1510.4 1633.2 1703.4 1705.8 1742.6 6514.4 6858.6 6865.1 6870.4 6870.5 6166.6 6249.4 6763.7 6996.7 7026.6 2066.4 2067.3 2069.8 2092.2 2094.1 1884.7 2040.7 2064.9 2069.3 2088.2 1870.0 1979.5 2059.2 2062.9 2064.8 2032.2 2068.2 2073.6 2074.7 2104.1 2090.7 2109.5 2112.3 2113.1 2114.4 6978.8 7084.1 7093.0 7103.6 7108.3 4081.7 4167.2 4201.6 4204.3 4204.7 2819.6 2864.5 2869.9 2874.5 2882.5 919.6 933.9 957.3 972.3 992.6 9477.9 9494.1 9499.0 9501.3 9508.5 3717.4 3718.1 3740.5 3752.9 3775.8 8200.7 8203.6 8209.2 8218.6 8229.6 4250.3 4254.8 4261.2 4261.8 4263.1 3887.6 3895.5 3899.7 3902.7 3903.6 3295.5 3298.2 3315.0 3356.7 3357.5 967.7 983.2 1031.9 1033.4 1038.9 924.5 924.9 990.5 1048.7 1251.8 6402.5 6441.2 6450.0 6451.9 6452.3 1081.5 1083.6 1095.8 1120.7 1123.5 5169.2 5182.8 5210.9 5231.4 5235.4 8189.3 8197.2 8322.4 8354.0 8392.0 8144.5 8196.4 8280.3 8311.2 8315.8 6595.5 6624.9 6650.6 6707.6 6711.4 6286.6 6465.3 6489.8 6510.8 6768.8 7157.9 7421.8 7471.8 7529.7 7539.8 7250.7 7376.7 7399.4 7509.6 7512.0 6220.5 6345.6 6401.6 6406.7 6407.9 6872.5 6969.1 6969.3 6970.1 6972.9 6475.1 6562.2 6569.0 6653.8 6667.2 5709.2 5779.9 6063.3 6186.7 6215.5 6366.1 6379.7 6414.6 6422.8 6426.8 5900.5 5917.4 5920.4 5927.2 5936.9 5915.9 5916.0 5936.2 5943.6 5955.0 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5307.90 Median:6079.80 stddev:1599.68 (26.3%) stddev-sans-first:1559.75 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: Values: 320.4 334.0 341.1 344.3 348.0 5937.7 6000.1 6000.4 6033.7 6037.7 5857.5 5905.1 5909.6 5916.8 5919.4 4617.3 4625.8 4626.1 4627.1 4629.2 4451.8 4591.5 4607.6 4614.0 4614.4 4562.0 4562.1 4563.5 4567.7 4567.7 4285.6 4353.7 4447.2 4566.1 4570.5 3953.5 3980.2 3982.0 3987.9 3993.6 5671.3 5682.6 5683.5 5691.7 5702.9 4935.2 5057.3 5148.8 5252.1 5290.5 6297.1 6311.6 6316.9 6318.7 6332.2 4385.3 4407.8 4410.3 4417.1 4417.2 6370.5 6463.4 6509.8 6524.5 6527.8 4470.2 4480.3 4484.0 4493.1 4493.5 4541.6 4542.7 4544.7 4545.1 4545.5 5267.5 5269.8 5270.2 5274.2 5277.1 6240.3 6359.8 6369.3 6372.6 6380.3 1583.6 1621.0 1621.4 1621.7 1622.7 1031.3 1050.5 1064.7 1075.8 1109.4 6121.9 6121.9 6125.8 6128.5 6131.4 6547.8 6574.3 6596.4 6601.0 6611.1 5987.1 6133.8 6133.9 6135.0 6138.3 3561.6 3581.7 3583.5 3584.0 3587.7 6668.2 6682.9 6683.6 6684.7 6689.8 6570.2 6624.3 6704.5 6710.4 6718.3 6507.9 6527.3 6545.5 6686.2 6761.9 6600.2 6628.5 6631.8 6648.4 6655.3 6321.1 6511.3 6518.1 6520.1 6536.4 6699.3 6700.6 6705.1 6709.4 6712.5 4553.0 4553.7 4557.5 4558.2 4561.7 6431.2 6588.2 6591.7 6595.7 6606.1 6419.6 6426.4 6428.0 6433.4 6439.2 6432.1 6432.4 6433.3 6434.3 6439.2 6182.2 6305.3 6315.7 6323.7 6348.8 6509.3 6509.6 6516.4 6519.4 6521.3 6336.4 6336.7 6339.8 6341.9 6345.7 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,153 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13676.77 Median:51188.62 stddev:16182.88 (31.6%) stddev-sans-first:16199.17 05:52:01 INFO - 2015-12-20 05:52:01,155 DEBUG : BROWSER_OUTPUT: Values: 751.9 816.4 823.6 826.2 828.8 12221.5 12471.8 12488.9 12512.3 12534.9 12103.5 12362.1 12376.9 12537.3 13489.2 803.5 812.9 813.4 814.5 814.9 692.8 700.4 806.9 814.6 834.3 857.2 858.8 865.9 868.8 869.5 716.8 860.9 861.1 861.3 862.2 532.5 617.2 627.4 627.5 628.4 12915.5 13287.6 13289.9 13291.3 13318.7 11272.8 11658.4 11685.6 11889.5 12190.4 9734.7 9768.9 9780.9 9857.2 10042.2 3555.9 3609.7 3652.0 3675.4 3681.3 49025.3 49124.5 49417.5 49432.5 49578.8 9591.0 9618.0 9696.6 9742.3 9835.1 17503.0 17572.0 17576.6 17630.0 17632.8 7153.3 7287.2 7306.2 7334.5 7400.1 4179.6 4196.7 4241.6 4296.6 4308.8 2853.3 2892.2 2893.7 2897.1 2898.4 517.1 518.5 526.2 541.3 547.5 590.5 631.2 645.2 652.3 711.2 8540.7 8753.7 8973.6 9056.1 9160.4 551.1 598.2 603.0 661.1 670.4 3743.4 3977.7 4047.6 4050.8 4057.0 56506.0 57428.7 57737.7 58006.4 58217.7 51155.7 51221.5 51254.0 51366.5 51766.5 46582.0 47265.5 47273.3 47332.3 48159.5 7968.1 7977.0 8128.2 8179.2 8278.3 35941.6 36259.0 36477.3 36580.8 37247.4 43019.6 44607.0 44853.6 45507.5 45818.5 9879.1 9918.5 10281.3 10545.7 10617.8 11462.4 11706.2 11726.8 11735.3 11791.7 10439.6 10470.3 10612.9 10684.4 10764.5 10208.4 10294.8 10500.6 10695.8 10939.3 10703.6 10768.1 10824.2 10880.1 11045.1 9559.9 9571.9 9626.6 9888.8 10170.7 8482.7 9013.4 9403.8 9564.2 9755.4 05:52:01 INFO - 2015-12-20 05:52:01,155 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:52:01 INFO - 2015-12-20 05:52:01,155 DEBUG : BROWSER_OUTPUT: 05:52:01 INFO - 2015-12-20 05:52:01,794 INFO : Browser exited with error code: 0 05:52:01 INFO - 2015-12-20 05:52:01,815 INFO : Completed test dromaeo_css (00:18:32) 05:52:01 INFO - 2015-12-20 05:52:01,815 INFO : Starting test kraken 05:52:01 INFO - 2015-12-20 05:52:01,815 DEBUG : operating with platform_type : linux_ 05:52:01 INFO - 2015-12-20 05:52:01,815 INFO : Initialising browser for kraken test... 05:52:01 INFO - 2015-12-20 05:52:01,821 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnUQYfZ/profile http://localhost:56234/getInfo.html 05:52:05 INFO - 2015-12-20 05:52:05,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:52:05 INFO - 2015-12-20 05:52:05,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:52:05 INFO - 2015-12-20 05:52:05,391 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:52:05 INFO - 2015-12-20 05:52:05,391 DEBUG : BROWSER_OUTPUT: __metrics 05:52:05 INFO - 2015-12-20 05:52:05,475 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:52:05 INFO - 2015-12-20 05:52:05,531 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:52:06 INFO - 2015-12-20 05:52:06,541 INFO : Browser initialized. 05:52:06 INFO - 2015-12-20 05:52:06,541 INFO : Running cycle 1/1 for kraken test... 05:52:06 INFO - 2015-12-20 05:52:06,542 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnUQYfZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:52:18 INFO - 2015-12-20 05:52:18,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 149716992 05:52:18 INFO - 2015-12-20 05:52:18,308 DEBUG : BROWSER_OUTPUT: 05:52:20 INFO - 2015-12-20 05:52:20,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56234/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:21 INFO - 2015-12-20 05:52:21,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 184295424 05:52:21 INFO - 2015-12-20 05:52:21,363 DEBUG : BROWSER_OUTPUT: 05:52:24 INFO - 2015-12-20 05:52:24,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56234/tests/kraken/driver.html?testName=audio-dft) 05:52:24 INFO - 2015-12-20 05:52:24,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 175153152 05:52:24 INFO - 2015-12-20 05:52:24,581 DEBUG : BROWSER_OUTPUT: 05:52:27 INFO - 2015-12-20 05:52:27,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56234/tests/kraken/driver.html?testName=audio-fft) 05:52:28 INFO - 2015-12-20 05:52:28,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 160415744 05:52:28 INFO - 2015-12-20 05:52:28,040 DEBUG : BROWSER_OUTPUT: 05:52:30 INFO - 2015-12-20 05:52:30,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56234/tests/kraken/driver.html?testName=audio-oscillator) 05:52:30 INFO - 2015-12-20 05:52:30,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 161427456 05:52:30 INFO - 2015-12-20 05:52:30,595 DEBUG : BROWSER_OUTPUT: 05:52:32 INFO - 2015-12-20 05:52:32,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:33 INFO - 2015-12-20 05:52:33,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 164397056 05:52:33 INFO - 2015-12-20 05:52:33,374 DEBUG : BROWSER_OUTPUT: 05:52:36 INFO - 2015-12-20 05:52:36,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56234/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:36 INFO - 2015-12-20 05:52:36,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 163909632 05:52:36 INFO - 2015-12-20 05:52:36,837 DEBUG : BROWSER_OUTPUT: 05:52:40 INFO - 2015-12-20 05:52:40,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56234/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:40 INFO - 2015-12-20 05:52:40,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 165625856 05:52:40 INFO - 2015-12-20 05:52:40,770 DEBUG : BROWSER_OUTPUT: 05:52:43 INFO - 2015-12-20 05:52:43,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56234/tests/kraken/driver.html?testName=json-parse-financial) 05:52:44 INFO - 2015-12-20 05:52:44,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 165306368 05:52:44 INFO - 2015-12-20 05:52:44,104 DEBUG : BROWSER_OUTPUT: 05:52:45 INFO - 2015-12-20 05:52:45,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:46 INFO - 2015-12-20 05:52:46,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 176779264 05:52:46 INFO - 2015-12-20 05:52:46,246 DEBUG : BROWSER_OUTPUT: 05:52:48 INFO - 2015-12-20 05:52:48,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:48 INFO - 2015-12-20 05:52:48,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 172257280 05:52:48 INFO - 2015-12-20 05:52:48,663 DEBUG : BROWSER_OUTPUT: 05:52:50 INFO - 2015-12-20 05:52:50,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:51 INFO - 2015-12-20 05:52:51,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 186736640 05:52:51 INFO - 2015-12-20 05:52:51,316 DEBUG : BROWSER_OUTPUT: 05:52:53 INFO - 2015-12-20 05:52:53,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:54 INFO - 2015-12-20 05:52:54,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 193236992 05:52:54 INFO - 2015-12-20 05:52:54,319 DEBUG : BROWSER_OUTPUT: 05:52:56 INFO - 2015-12-20 05:52:56,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:57 INFO - 2015-12-20 05:52:57,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 190582784 05:52:57 INFO - 2015-12-20 05:52:57,488 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56234/tests/kraken/driver.html?testName=ai-astar) 05:52:59 INFO - 2015-12-20 05:52:59,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 249053184 05:52:59 INFO - 2015-12-20 05:52:59,428 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;109;110;111;100;111;110;111 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;123;154;166;138;155;148;132;160;122 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;159;161;160;160;162;161;161 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;90;95;71;72;71;99;86;70 05:52:59 INFO - 2015-12-20 05:52:59,432 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;148;93;95;94;135;101;94;140 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;111;110;110;110;109 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;145;146;146;147;146;146;145;147 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;96;95;95;96;96 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;58;58;59;60;63;60;60;56 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;67;67;74;68;67;67;67 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;83;84;84;84;85;84;84;92 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;128;115;118;125;121;116;122;130;117 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;153;150;148;150;141;151;150;151;141 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;67;71;65;66;70;66;68 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:52:59 INFO - 2015-12-20 05:52:59,433 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:52:59 INFO - 2015-12-20 05:52:59,434 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,962 05:52:59 INFO - 2015-12-20 05:52:59,434 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:52:59 INFO - 2015-12-20 05:52:59,434 DEBUG : BROWSER_OUTPUT: __startTimestamp1450619579430__endTimestamp 05:52:59 INFO - 2015-12-20 05:52:59,434 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:3.71 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 109.0 110.0 111.0 100.0 111.0 110.0 111.0 05:52:59 INFO - 2015-12-20 05:52:59,435 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.00 Median:153.00 stddev:15.41 (10.1%) stddev-sans-first:16.13 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: Values: 152.0 123.0 154.0 166.0 138.0 155.0 148.0 132.0 160.0 122.0 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 159.0 161.0 160.0 160.0 162.0 161.0 161.0 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:79.50 stddev:11.36 (14.3%) stddev-sans-first:11.68 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 90.0 95.0 71.0 72.0 71.0 99.0 86.0 70.0 05:52:59 INFO - 2015-12-20 05:52:59,436 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,437 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:22.41 (23.8%) stddev-sans-first:23.27 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 148.0 93.0 95.0 94.0 135.0 101.0 94.0 140.0 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 111.0 110.0 110.0 110.0 109.0 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 05:52:59 INFO - 2015-12-20 05:52:59,438 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.50 stddev:1.85 (3.1%) stddev-sans-first:1.92 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 58.0 58.0 59.0 60.0 63.0 60.0 60.0 56.0 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:2.26 (3.4%) stddev-sans-first:2.32 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 67.0 74.0 68.0 67.0 67.0 67.0 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.63 (3.1%) stddev-sans-first:2.71 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 83.0 84.0 84.0 84.0 85.0 84.0 84.0 92.0 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:5.46 (4.5%) stddev-sans-first:5.39 05:52:59 INFO - 2015-12-20 05:52:59,439 DEBUG : BROWSER_OUTPUT: Values: 115.0 128.0 115.0 118.0 125.0 121.0 116.0 122.0 130.0 117.0 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:150.00 stddev:5.25 (3.5%) stddev-sans-first:4.36 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: Values: 138.0 153.0 150.0 148.0 150.0 141.0 151.0 150.0 151.0 141.0 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 71.0 65.0 66.0 70.0 66.0 68.0 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:52:59 INFO - 2015-12-20 05:52:59,440 DEBUG : BROWSER_OUTPUT: 05:53:00 INFO - 2015-12-20 05:53:00,305 INFO : Browser exited with error code: 0 05:53:00 INFO - 2015-12-20 05:53:00,360 INFO : Completed test kraken (00:00:58) 05:53:00 INFO - 2015-12-20 05:53:00,360 INFO : Starting test v8_7 05:53:00 INFO - 2015-12-20 05:53:00,360 DEBUG : operating with platform_type : linux_ 05:53:00 INFO - 2015-12-20 05:53:00,361 INFO : Initialising browser for v8_7 test... 05:53:00 INFO - 2015-12-20 05:53:00,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOogoSg/profile http://localhost:56234/getInfo.html 05:53:04 INFO - 2015-12-20 05:53:04,263 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:04 INFO - 2015-12-20 05:53:04,263 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:04 INFO - 2015-12-20 05:53:04,263 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:53:04 INFO - 2015-12-20 05:53:04,263 DEBUG : BROWSER_OUTPUT: __metrics 05:53:04 INFO - 2015-12-20 05:53:04,351 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:53:04 INFO - 2015-12-20 05:53:04,407 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:53:05 INFO - 2015-12-20 05:53:05,237 INFO : Browser initialized. 05:53:05 INFO - 2015-12-20 05:53:05,238 INFO : Running cycle 1/1 for v8_7 test... 05:53:05 INFO - 2015-12-20 05:53:05,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOogoSg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:17 INFO - 2015-12-20 05:53:17,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 150491136 05:53:17 INFO - 2015-12-20 05:53:17,053 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56234/tests/v8_7/run.html (next: http://localhost:56234/tests/v8_7/run.html) 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 474660864 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:53:38 INFO - 2015-12-20 05:53:38,768 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7550140891762 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.43037497644622 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |5;Earley;759.3014426727411 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |7;RegExp;24975.60975609756 05:53:38 INFO - 2015-12-20 05:53:38,769 DEBUG : BROWSER_OUTPUT: |8;Splay;1131.1659192825111 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1450619618767__endTimestamp 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:53:38 INFO - 2015-12-20 05:53:38,770 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:53:38 INFO - 2015-12-20 05:53:38,771 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,771 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.76 Median:165.76 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,771 DEBUG : BROWSER_OUTPUT: Values: 165.8 05:53:38 INFO - 2015-12-20 05:53:38,771 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,771 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: Values: 188.4 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: Values: 281.5 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,772 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,773 DEBUG : BROWSER_OUTPUT: Values: 5122.4 05:53:38 INFO - 2015-12-20 05:53:38,773 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,774 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,774 DEBUG : BROWSER_OUTPUT: Values: 1970.5 05:53:38 INFO - 2015-12-20 05:53:38,775 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,775 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:759.30 Median:759.30 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,775 DEBUG : BROWSER_OUTPUT: Values: 759.3 05:53:38 INFO - 2015-12-20 05:53:38,775 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,775 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: Values: 12180.7 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24975.61 Median:24975.61 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: Values: 24975.6 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,776 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1131.17 Median:1131.17 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: Values: 1131.2 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: Values: 4826.9 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:53:38 INFO - 2015-12-20 05:53:38,777 DEBUG : BROWSER_OUTPUT: 05:53:39 INFO - 2015-12-20 05:53:39,609 INFO : Browser exited with error code: 0 05:53:39 INFO - 2015-12-20 05:53:39,624 INFO : Completed test v8_7 (00:00:39) 05:53:39 INFO - 2015-12-20 05:53:39,700 INFO : Completed test suite (00:20:09) 05:53:39 INFO - 2015-12-20 05:53:39,701 DEBUG : Working with test: dromaeo_css 05:53:39 INFO - 2015-12-20 05:53:39,701 DEBUG : Generating results file: dromaeo_css 05:53:39 INFO - 2015-12-20 05:53:39,702 DEBUG : Working with test: kraken 05:53:39 INFO - 2015-12-20 05:53:39,702 DEBUG : Generating results file: kraken 05:53:39 INFO - 2015-12-20 05:53:39,702 INFO : javascript benchmark 05:53:39 INFO - 2015-12-20 05:53:39,702 DEBUG : Working with test: v8_7 05:53:39 INFO - 2015-12-20 05:53:39,702 DEBUG : Generating results file: v8_7 05:53:39 INFO - 2015-12-20 05:53:39,703 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:39 INFO - 2015-12-20 05:53:39,758 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:53:39 INFO - 2015-12-20 05:53:39,758 DEBUG : process_Request line: dromaeo_css 6791.33 graph.html#tests=[[72,1,35]] 05:53:39 INFO - 2015-12-20 05:53:39,759 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:39 INFO - 2015-12-20 05:53:39,786 DEBUG : process_Request line: kraken 1501.20 graph.html#tests=[[232,1,35]] 05:53:39 INFO - 2015-12-20 05:53:39,786 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:39 INFO - 2015-12-20 05:53:39,816 DEBUG : process_Request line: v8_7 18818.99 graph.html#tests=[[230,1,35]] 05:53:39 INFO - 2015-12-20 05:53:39,817 INFO : javascript benchmark 05:53:39 INFO - 2015-12-20 05:53:39,821 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3078.1381213260283, 3194.1056504178837, 3194.552762613236, 3204.791688540244, 3217.581714377129, 5064.037832811763, 5201.0898092833795, 5221.164613661815, 5269.973650131748, 5309.0709125903, 5191.6365854390115, 5272.340957380327, 5276.287701160342, 5325.0148722486365, 5325.281087053257, 4831.0, 4863.14894893394, 4868.269759536062, 4871.707697538159, 4927.581155601778, 4900.926486102711, 4932.679375840559, 4934.777934992916, 4958.9752051239875, 4970.577500912426, 4714.104320179155, 4767.165745994437, 4826.251930950708, 4873.122837889178, 4886.902261954759, 4870.6103511718975, 4876.0, 4902.166631672624, 4915.48387419323, 4918.385201849769, 4850.636202284807, 4855.223164293731, 4857.6599638025355, 4865.2945322928335, 4891.975540122312, 4946.431160416562, 5050.116229659795, 5080.263361812516, 5143.974280128613, 5209.661372010807, 5695.943040569583, 5700.800471983503, 5710.971445142748, 5711.543076553866, 5720.342160651537, 5727.055035919068, 5727.713614319267, 5730.627509211888, 5731.083026715705, 5733.942660573382, 5177.637565370425, 5278.604104692164, 5291.99452104099, 5403.2705584746345, 5444.40111587725, 5655.349634791969, 5672.517835983905, 5682.772689092472, 5688.943110568925, 5700.714964251771, 5456.7544460499375, 5506.834794956158, 5507.228987941691, 5513.2005859150195, 5533.557315414757, 5585.050541407971, 5600.103983362643, 5634.690092044895, 5722.685252311079, 5770.394108618619, 5754.568407369464, 5758.539316854642, 5759.107338362477, 5760.452756988079, 5765.04876695349, 5457.20870473787, 5700.771969121189, 5706.42935706426, 5751.051076572402, 5758.452946970031, 4314.80583373749, 4319.460067491564, 4337.587929146726, 4372.453443319585, 4445.955540444619, 3968.027833180889, 3971.860984865516, 3986.2226865761477, 4006.1186538961383, 4018.3570628699267, 5400.324959380077, 5407.864803379947, 5408.323959505062, 5408.594355423359, 5415.593830462731, 5643.915341269884, 5671.347795003545, 5778.451047150514, 5784.334801497882, 5784.479396854304, 5401.189821526724, 5405.189221616711, 5426.782928682887, 5433.8369848904595, 5454.809081682122, 5024.949750502521, 5025.221090730943, 5026.346574945233, 5027.4469808321055, 5068.721220332844, 5621.690807005572, 5807.186993820868, 5814.563907706939, 5817.76728930838, 5823.82528524145, 5730.054541000855, 5731.713414329351, 5781.739821707949, 5816.069428891357, 5848.941510584839, 5848.473637372657, 5856.531477481876, 5858.238429004202, 5862.882742345215, 5863.648181108976, 5654.46282603152, 5656.013875874758, 5693.857653558694, 5710.4004079572705, 5716.971415142898, 5546.0, 5673.574481913955, 5693.715314234355, 5787.421257874179, 5803.47768700819, 5541.418151094238, 5542.140968149944, 5549.195366671891, 5549.361823390201, 5591.916121258266, 5514.696691681996, 5529.336479622471, 5534.584906131976, 5535.142052981794, 5544.972275138599, 5359.14253719403, 5419.295491586068, 5437.102878025082, 5478.698671572943, 5501.944980550144, 5563.860903477445, 5571.3592936811165, 5590.133529302964, 5594.440555944373, 5703.372629010889, 5461.863453413696, 5464.398916119144, 5470.671759694431, 5471.316085489314, 5490.203920431595], "unit": "score", "name": "dojo.html", "value": 5252.367427319966}, {"lowerIsBetter": false, "replicates": [548.1032741958749, 579.3279795437293, 596.221930380853, 601.7562887030751, 603.3272900715704, 30022.24944376389, 38809.22381552371, 38997.02507437319, 39060.21879562414, 39084.80457597708, 41881.0, 42092.0, 42283.36574951378, 42352.152956940845, 42374.78812605933, 7356.521826081314, 7484.513506622052, 8617.827643447128, 8797.824043519158, 8800.559972001374, 10217.438040907784, 10431.791364172712, 10439.634612788554, 10442.112420444271, 10442.791144177112, 10266.897331026707, 10316.690499285034, 10365.585376584928, 10378.0, 10391.896081039205, 7750.612469376509, 7932.127465978738, 7939.126696063428, 10259.846102308435, 10331.328463649914, 10123.0, 10258.230632702576, 10264.127549158331, 10266.948665256627, 10269.743256418575, 39138.412923806165, 39566.0, 39573.80213098916, 39585.20829583421, 39621.40567891484, 2716.375233696261, 2765.092086460336, 2799.384135490189, 2859.4995875721665, 3369.7304215662934, 28592.571111433346, 28833.0, 29043.0, 29113.126606201848, 29529.0, 3458.6714262145056, 3480.9651903480894, 3523.6476352364557, 3588.802615856153, 3647.6170002149925, 252046.47953520413, 252839.0, 254253.0, 254591.0, 255058.99999999814, 57740.71129644409, 58672.706636467396, 59601.40398596045, 59794.40205597975, 60453.39546604566, 58239.417605824245, 59049.70475147597, 59244.0, 59501.404985949586, 59540.70229648824, 15080.849191508163, 15225.238738063052, 15228.619284517976, 15319.61700957485, 15342.923285383726, 11940.641780746419, 12023.699407514881, 12028.218165819193, 12146.392680365947, 12250.387480626112, 19825.900870495843, 20072.69890951637, 20102.798972010092, 20191.4952126198, 20235.696464553042, 7798.961005194938, 7963.761087167394, 8020.598970051474, 8029.317508011768, 8187.345012398994, 851.3572252949108, 873.4015854678764, 977.2182254196756, 1040.2302296300834, 1055.3087727538475, 27972.44055118886, 28256.43487130246, 28293.85853070763, 28639.427211455655, 28644.0, 963.8554216867526, 1009.1976878381704, 1048.6696690542608, 1106.7288514313884, 1136.1251836086167, 14765.852341476448, 14963.70072598542, 14981.550553483414, 15168.772468412983, 15230.314635841414, 294862.0, 298151.0, 300821.0, 301430.0, 301585.0, 52469.0, 53274.20088698673, 53275.20087198695, 53289.2006619901, 53305.46694533082, 1262.4319056424645, 1286.8005459153846, 1293.1465232946211, 1295.371744703818, 1316.2168509736691, 23829.213394017384, 27432.17703468899, 28179.57730634083, 28212.0, 28348.216512846095, 37759.43360849535, 38137.61862381452, 38147.237055258185, 42840.64491938508, 42935.78532107319, 196417.0, 196516.0, 197085.0, 197543.0, 197747.0, 27632.44735105327, 28042.579361310003, 30369.544456832722, 31465.37069258648, 31514.212144696565, 37654.811725941196, 37680.623193767715, 38402.42396364001, 38639.0, 38677.0, 34115.31769364649, 34457.13857153491, 35073.82463087668, 35153.25908925816, 35475.29049418945, 34425.311493769485, 35152.47271290881, 35208.823955880056, 35245.82377088201, 40512.392314114724, 35243.82378088093, 35621.82189089038, 35838.64161358353, 36040.819795900854, 36131.0, 30971.69028309688, 32287.677123228466, 32892.0, 33048.33903321968, 33060.834695826365, 24520.264392067555, 25180.24459266225, 26312.8684356577, 27679.30801729973, 28357.149285521467], "unit": "score", "name": "ext.html", "value": 18102.80247227616}, {"lowerIsBetter": false, "replicates": [353.2140986305469, 356.65760869565213, 357.4995006990213, 359.61880406768813, 360.8268031344954, 14125.646858828535, 14351.28243587819, 16372.754408683864, 17139.82860171398, 18206.08969551522, 14057.297135143253, 15341.616459588487, 15376.23118844059, 15599.0, 17506.824931750678, 5305.814296499633, 5436.891262174774, 5437.374701909272, 5439.048166570854, 5440.972795136019, 5241.082810508165, 5377.892442151155, 5382.165764306519, 5383.43473935237, 5386.78452861885, 5329.094054010808, 5329.280547126146, 5341.03861304965, 5346.759395827197, 5350.678959262437, 5245.108331583621, 5373.650712703662, 5382.811601593945, 5384.946150538503, 5390.460953904618, 4826.782794774209, 4828.855134345975, 4832.806687732486, 4835.637327200438, 4836.661433699607, 18828.24687012518, 19435.416937491897, 20813.063412146337, 21236.0, 21281.57436851254, 1858.656148612511, 1958.5005823514912, 2008.658528050235, 2049.077914938269, 2178.1069761397753, 8518.74443766688, 8951.23914467271, 9077.546122693839, 9382.577783999737, 12561.246325220516, 1729.2218501674172, 1746.9301227950866, 1762.2246211666825, 1799.379214171109, 1827.725841123842, 50034.49965500371, 50045.499545004444, 50814.7459262705, 56722.43277567254, 63042.68478657577, 8980.820383592421, 9935.254855885838, 9941.950290248502, 10050.69847904564, 10119.494025298705, 13125.212487250796, 13174.0, 13196.868031319756, 13217.405216765268, 13221.140625859289, 7050.541714788625, 7052.0, 7108.431325493948, 7164.713411463587, 7283.890741638879, 6687.1975362956755, 6697.732090716414, 6925.722971081101, 7024.824379390454, 7105.538140020882, 4179.6029377209115, 4263.445752052214, 4331.610155086058, 4459.0, 4490.797914093809, 1836.97244541332, 1842.4472658202753, 1868.215349553191, 1879.9906000470185, 1894.6116046210493, 793.4961299574811, 951.5052172870069, 960.1023043454253, 981.9395053342373, 1033.3748082410184, 14653.560393188221, 16544.917275413547, 16550.0, 16876.240569174417, 17103.14484275781, 857.8112815180775, 866.7313132928812, 931.1340453378423, 948.0756262643868, 979.4368238262884, 8173.509589424653, 9364.62541498346, 9463.858042129235, 9670.56482458291, 9747.171490423394, 486537.0, 494458.0, 496437.0, 498540.0, 498619.0, 84021.0, 84274.0, 84446.57776711076, 85680.57159714162, 86176.56911715401, 1064.7018834726289, 1075.0593230922943, 1076.1175835814556, 1077.9892201078046, 1095.6329629574022, 15480.148591827558, 15664.530064098095, 16023.439179628656, 16098.67802643964, 16235.431759888348, 35289.29421411609, 35533.64466355303, 36124.81937590295, 36831.0, 36869.26261474809, 47551.5244847561, 47578.76210618925, 48160.518394815605, 49403.0, 52361.47638523566, 8952.641894324153, 9817.509124543887, 9859.753506162404, 9865.901340986786, 9950.35322704022, 11222.102231821598, 11242.269252498561, 11311.264767790068, 11319.547218111184, 11331.490082946122, 13500.729985400434, 13943.790843137564, 14048.648783780487, 14293.499727509487, 14443.133411995314, 14159.64600884986, 14216.644583885485, 14276.500322488662, 14297.0, 14300.570982870531, 14469.421223150955, 14651.633709157357, 14802.703945921237, 14886.702265954837, 15405.845941540441, 7977.242161994601, 9245.72262832116, 9778.41329520231, 9787.608495660093, 9788.80422391534, 9775.413475191512, 9856.753581160528, 12092.516299348279, 14442.783358249424, 14826.110433374031], "unit": "score", "name": "jquery.html", "value": 8598.351898071955}, {"lowerIsBetter": false, "replicates": [1510.3580978084312, 1633.1507616039657, 1703.3782669325692, 1705.7782488276523, 1742.6340468501614, 6514.381133792294, 6858.588484690922, 6865.073215115958, 6870.38166565009, 6870.450363970883, 6166.630002199871, 6249.375062493748, 6763.729450821961, 6996.650167491631, 7026.613536255504, 2066.4110728442397, 2067.2867860588112, 2069.8447616428753, 2092.204962114394, 2094.0890712540017, 1884.6701827180257, 2040.714299997994, 2064.9483762905897, 2069.3481553310735, 2088.2064815370136, 1869.9813001870011, 1979.4655443030374, 2059.1763294682096, 2062.9174833006664, 2064.834813214939, 2032.1668116072487, 2068.214078650111, 2073.5749171419825, 2074.7406574178226, 2104.105755054096, 2090.686397040456, 2109.504266497372, 2112.26070875194, 2113.0596884386455, 2114.38682781993, 6978.79063628092, 7084.14990201174, 7093.0, 7103.644817759143, 7108.253633368474, 4081.7346872453195, 4167.249895018896, 4201.6008479194425, 4204.264253755611, 4204.726692764961, 2819.6183869903803, 2864.5273529867545, 2869.880746508863, 2874.5257032589598, 2882.524383476724, 919.6183583812709, 933.9252859771202, 957.2676902169845, 972.3096601413005, 992.6277645882794, 9477.90522094784, 9494.145526902612, 9498.9525052375, 9501.2874034447, 9508.47703376314, 3717.4052151655605, 3718.1448266898765, 3740.457633643161, 3752.887413377603, 3775.8300876460626, 8200.671973121009, 8203.58982050895, 8209.220124088202, 8218.589070546448, 8229.629666664894, 4250.3199488081755, 4254.829806807693, 4261.21167583998, 4261.786910654455, 4263.126059157928, 3887.5918028607157, 3895.454636350913, 3899.66852817508, 3902.687784977195, 3903.5510916244993, 3295.4727243641382, 3298.224917144469, 3314.950275745866, 3356.6643335666727, 3357.496375543688, 967.7145242153582, 983.233078199006, 1031.9432431216355, 1033.4316126130598, 1038.9428581428094, 924.473050361301, 924.8751418558543, 990.4997976022063, 1048.7430579507916, 1251.7809383357876, 6402.519811014193, 6441.1626488556185, 6450.032495125769, 6451.870962580722, 6452.290248072708, 1081.5187241677536, 1083.6207327435334, 1095.8191898336845, 1120.7310245541012, 1123.5225029362489, 5169.172932330809, 5182.844514664566, 5210.869728256824, 5231.372235331708, 5235.424103348629, 8189.344852411793, 8197.180281971874, 8322.417430779908, 8353.95823020881, 8391.95804020976, 8144.511329320259, 8196.385271104691, 8280.254777069973, 8311.210435008665, 8315.750527484186, 6595.538312318092, 6624.900626490607, 6650.600963942082, 6707.5975441473665, 6711.395974362331, 6286.591371560834, 6465.2564955030775, 6489.805305840832, 6510.837229069311, 6768.763093291711, 7157.892631610634, 7421.777346679392, 7471.813204669927, 7529.736459223901, 7539.811504712426, 7250.673719682733, 7376.7049318026675, 7399.445041622008, 7509.6245187739305, 7511.9624401877645, 6220.533459990609, 6345.555811093363, 6401.583897046677, 6406.743730250924, 6407.871842563216, 6872.518923675495, 6969.059177011039, 6969.30306969299, 6970.128733908262, 6972.860542789014, 6475.093486911742, 6562.179727534059, 6569.0, 6653.800385988428, 6667.19993600771, 5709.200711900255, 5779.855503612275, 6063.272407311151, 6186.659733714689, 6215.502759779117, 6366.076918846834, 6379.681015949277, 6414.550981431255, 6422.775202867877, 6426.839329016812, 5900.498457630978, 5917.37867523921, 5920.37836027211, 5927.229460170151, 5936.881262374642, 5915.881682366415, 5916.0, 5936.198613187337, 5943.58394912352, 5955.0], "unit": "score", "name": "mootools.html", "value": 4070.1297212681848}, {"lowerIsBetter": false, "replicates": [320.4168413487454, 333.9532465454837, 341.07228338918134, 344.2924789557458, 348.0185875830157, 5937.732802023908, 6000.069989151683, 6000.399960003997, 6033.668148251844, 6037.698115094249, 5857.531397488201, 5905.143754155645, 5909.556783241253, 5916.787058652976, 5919.37846526115, 4617.261238201889, 4625.814967401317, 4626.121037002967, 4627.097715945392, 4629.213033784248, 4451.777411129447, 4591.47198072221, 4607.58531732144, 4614.0, 4614.353990441324, 4562.041971186055, 4562.064776720781, 4563.543645635426, 4567.65742569307, 4567.725936443808, 4285.5928686774705, 4353.73877567347, 4447.155040542287, 4566.10960862632, 4570.451545814491, 3953.525576930758, 3980.223856348013, 3981.98009009956, 3987.920241595181, 3993.5806740292433, 5671.319441666985, 5682.6306290091425, 5683.460071293221, 5691.715414229313, 5702.885942281173, 4935.210366341368, 5057.291979122889, 5148.819791307286, 5252.107141785906, 5290.4974027467715, 6297.149884765544, 6311.621302721851, 6316.905246421307, 6318.74725010999, 6332.240131184241, 4385.298352263654, 4407.845725399596, 4410.294352903552, 4417.072414792898, 4417.226985277595, 6370.458511026568, 6463.385978332051, 6509.837254068639, 6524.543281970264, 6527.804165875032, 4470.195364834296, 4480.32795080734, 4483.977580112144, 4493.056458143827, 4493.505714371417, 4541.613962813131, 4542.659300552472, 4544.6818722689095, 4545.068261006486, 4545.477270113979, 5267.499587539178, 5269.789208431696, 5270.235815806686, 5274.156135018378, 5277.076511610453, 6240.344763799826, 6359.8092057238355, 6369.299377068519, 6372.553921225563, 6380.330065343072, 1583.580351206908, 1621.0273835698722, 1621.4000819696787, 1621.6918785430967, 1622.7484739865104, 1031.28841099641, 1050.5272627317738, 1064.6646306413454, 1075.8386242063752, 1109.4397329348628, 6121.908171377433, 6121.938780612226, 6125.816225513153, 6128.4790792783115, 6131.356207598227, 6547.770828021092, 6574.276829548746, 6596.373344532261, 6601.0, 6611.140551728245, 5987.1318658794235, 6133.815985520441, 6133.926562851572, 6135.049067394561, 6138.294096178996, 3561.5726112866105, 3581.7492775505984, 3583.51284217047, 3583.982080089635, 3587.7488575799966, 6668.199816022108, 6682.899756503656, 6683.565568238049, 6684.665766711645, 6689.832754181087, 6570.178727659043, 6624.304448032984, 6704.497162712816, 6710.396064354231, 6718.328167183243, 6507.9023814642815, 6527.34726527353, 6545.476361891037, 6686.197656281277, 6761.898571521431, 6600.2409722882485, 6628.5028622852515, 6631.834204144935, 6648.368405001517, 6655.267920528835, 6321.146645202839, 6511.2512061113575, 6518.054882041983, 6520.087187793618, 6536.411722944958, 6699.330066993261, 6700.597964122168, 6705.09481220029, 6709.36261055199, 6712.530122891546, 4552.954470455253, 4553.749543774991, 4557.453105627346, 4558.179527685049, 4561.703489273186, 6431.196100487439, 6588.176477940257, 6591.703373348115, 6595.703193356215, 6606.141201643755, 6419.55063145594, 6426.4216220540375, 6428.003659432796, 6433.388828061326, 6439.227292724903, 6432.13166222554, 6432.38892305249, 6433.292337842927, 6434.292227855026, 6439.195100612424, 6182.196314479089, 6305.337939516285, 6315.652639104894, 6323.683815809283, 6348.777792777415, 6509.316521765336, 6509.641969691713, 6516.380943810331, 6519.4132528072705, 6521.347865213441, 6336.398042185985, 6336.651484168415, 6339.778107766206, 6341.904871427025, 6345.650989195638], "unit": "score", "name": "prototype.html", "value": 4787.445477044611}, {"lowerIsBetter": false, "replicates": [751.8834580640003, 816.3754727633361, 823.5882058970515, 826.1862065865123, 828.8135169586843, 12221.511139554419, 12471.750564988695, 12488.937555312223, 12512.311822849739, 12534.874651253485, 12103.455344509497, 12362.134650574464, 12376.876231237686, 12537.31044792536, 13489.190648561093, 803.4536515169697, 812.8821320908464, 813.3655748516137, 814.5235037503068, 814.9307308878753, 692.7540723043322, 700.3976580141075, 806.9435139540235, 814.6130587970725, 834.2616784146044, 857.1771099744253, 858.7853036740814, 865.9134086591322, 868.8088620503479, 869.5043825019741, 716.8422946951662, 860.8579584368572, 861.1001503428901, 861.3152543727751, 862.1593945902727, 532.51541097601, 617.1729881958153, 627.4227710506345, 627.4980015987192, 628.3936001758279, 12915.547955821501, 13287.601371958857, 13289.86710132896, 13291.3354332283, 13318.667033324147, 11272.774544509064, 11658.358790266531, 11685.649430517098, 11889.464974076187, 12190.39048047594, 9734.659286924923, 9768.853467197998, 9780.853287200698, 9857.211423086135, 10042.246831487595, 3555.9111022224392, 3609.693176080036, 3652.0, 3675.4303083022173, 3681.2821499807546, 49025.264621030714, 49124.50875491235, 49417.50582494165, 49432.50567494315, 49578.7521062396, 9590.952045239868, 9618.0, 9696.61213551464, 9742.269329800294, 9835.114839664464, 17503.0, 17572.03353815527, 17576.56058598545, 17630.0, 17632.795900512436, 7153.284671532805, 7287.198408175096, 7306.159791623925, 7334.48658593904, 7400.147266612301, 4179.623833854967, 4196.727212731163, 4241.554636763157, 4296.634786043159, 4308.806103725277, 2853.2724155340256, 2892.190186747714, 2893.7106289370895, 2897.058456001808, 2898.3623602807347, 517.1002455727008, 518.4530320511897, 526.2369564132024, 541.3449725831709, 547.5127136848208, 590.4803772680015, 631.207834168116, 645.2482857470993, 652.2727159217438, 711.2425267090532, 8540.658373665108, 8753.737387878375, 8973.551322433852, 9056.094390560891, 9160.404573702688, 551.1168278625655, 598.2103623217398, 602.9638221706712, 661.1240106858431, 670.4267850987336, 3743.3823419136083, 3977.721559490808, 4047.6178651423147, 4050.8177132029127, 4056.9594304057173, 56506.0, 57428.71285643629, 57737.71131144317, 58006.41993580094, 58217.70891145517, 51155.744221278655, 51221.487785122416, 51254.0, 51366.48633513617, 51766.48233517692, 46582.0, 47265.5273447268, 47273.290900636515, 47332.29001564979, 48159.518404815506, 7968.123506414406, 7977.0, 8128.227818357246, 8179.182081791773, 8278.296344810758, 35941.64058359383, 36259.0, 36477.27045459129, 36580.81709591435, 37247.44128838124, 43019.56980430281, 44607.0, 44853.55146448624, 45507.54492455033, 45818.541814581426, 9879.110880020833, 9918.504074796376, 10281.331713438603, 10545.683629491128, 10617.787644247226, 11462.369569673749, 11706.180567360203, 11726.765464690829, 11735.295882247092, 11791.705207369885, 10439.582416703246, 10470.31942923738, 10612.893871061191, 10684.358938463716, 10764.46177691128, 10208.438535880301, 10294.845577316197, 10500.579976801147, 10695.786084278427, 10939.28894621847, 10703.625373111903, 10768.084712799186, 10824.24230303871, 10880.129589632968, 11045.116390688887, 9559.94840567551, 9571.904280957102, 9626.614935402506, 9888.847444983216, 10170.745731356776, 8482.682188963268, 9013.414128081653, 9403.811923761623, 9564.234861211226, 9755.365901216399], "unit": "score", "name": "yui.html", "value": 6158.276182272479}], "name": "dromaeo_css", "value": 6791.329481254028}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 110.0, 111.0, 100.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 154.0, 166.0, 138.0, 155.0, 148.0, 132.0, 160.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 159.0, 161.0, 160.0, 160.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 90.0, 95.0, 71.0, 72.0, 71.0, 99.0, 86.0, 70.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 148.0, 93.0, 95.0, 94.0, 135.0, 101.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 60.0, 63.0, 60.0, 60.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 74.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [115.0, 128.0, 115.0, 118.0, 125.0, 121.0, 116.0, 122.0, 130.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [138.0, 153.0, 150.0, 148.0, 150.0, 141.0, 151.0, 150.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 71.0, 65.0, 66.0, 70.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1501.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7550140891762], "unit": "score", "name": "Richards", "value": 212.97696600000003}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [759.3014426727411], "unit": "score", "name": "Earley", "value": 877.7317710000001}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [24975.60975609756], "unit": "score", "name": "RegExp", "value": 36.47498535156248}, {"lowerIsBetter": false, "replicates": [1131.1659192825111], "unit": "score", "name": "Splay", "value": 72.0415976214073}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18818.988069271894}]} 05:53:39 INFO - RETURN: dromaeo_css: 6791.33 05:53:39 INFO - RETURN: kraken: 1501.20 05:53:39 INFO - RETURN: v8_7: 18818.99 05:53:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18818.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1501.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6791.33"}}} 05:53:39 INFO - Return code: 0 05:53:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:53:39 ERROR - # TBPL SUCCESS # 05:53:39 INFO - Running post-action listener: _resource_record_post_action 05:53:39 INFO - Running post-run listener: _resource_record_post_run 05:53:41 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557920256; Read time: 176; Write time: 629080 05:53:41 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 250720256; Read time: 0; Write time: 389856 05:53:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306335744; Read time: 176; Write time: 239180 05:53:41 INFO - Running post-run listener: _upload_blobber_files 05:53:41 INFO - Blob upload gear active. 05:53:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:53:41 INFO - Copying logs to upload dir... 05:53:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.565543 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-20 05:53:38.318657) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:53:38.322496) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010011 build_url: 'https://queue.taskcluster.net/v1/task/9F5c3q79SpuVjSjdwSVq7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 05:53:38.379705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:53:38.380079) ========= 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=919420d7ee4ef147bef0346300000385-1450608388.377707-2136201286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 05:53:38.433320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 05:53:38.433679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 05:53:38.434002) ========= ========= Total master_lag: 0.26 =========