builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1460970493.64 results: success (0) buildid: 20160417233026 builduid: 9815e164ec184bc98272d3180d045df5 revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.635825) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.636382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.636661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.655666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.655944) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 02:08:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.2M=0s 2016-04-18 02:08:13 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.801558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.801843) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014211 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.882228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 02:08:13.882543) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 02:08:13,994 truncating revision to first 12 chars 2016-04-18 02:08:13,994 Setting DEBUG logging. 2016-04-18 02:08:13,995 attempt 1/10 2016-04-18 02:08:13,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d5b0cdb72fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 02:08:14,249 unpacking tar archive at: fx-team-4d5b0cdb72fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551908 ========= master_lag: 0.74 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 02:08:15.179069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.179420) ========= script_repo_revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.179818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.180115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.210919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 02:08:15.211251) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:08:15 INFO - MultiFileLogger online at 20160418 02:08:15 in /builds/slave/test 02:08:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:08:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:15 INFO - {'append_to_log': False, 02:08:15 INFO - 'base_work_dir': '/builds/slave/test', 02:08:15 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:15 INFO - 'branch': 'Fx-Team', 02:08:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:15 INFO - 'config_files': ('talos/linux_config.py',), 02:08:15 INFO - 'default_actions': ('clobber', 02:08:15 INFO - 'read-buildbot-config', 02:08:15 INFO - 'download-and-extract', 02:08:15 INFO - 'populate-webroot', 02:08:15 INFO - 'create-virtualenv', 02:08:15 INFO - 'install', 02:08:15 INFO - 'run-tests'), 02:08:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:15 INFO - 'download_minidump_stackwalk': True, 02:08:15 INFO - 'download_symbols': 'ondemand', 02:08:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:15 INFO - 'installer_path': 'installer.exe', 02:08:15 INFO - 'log_level': 'info', 02:08:15 INFO - 'log_name': 'talos', 02:08:15 INFO - 'log_to_console': True, 02:08:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:08:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:08:15 INFO - 'opt_config_files': (), 02:08:15 INFO - 'pip_index': False, 02:08:15 INFO - 'sps_profile': False, 02:08:15 INFO - 'sps_profile_interval': 0, 02:08:15 INFO - 'suite': 'dromaeojs', 02:08:15 INFO - 'system_bits': '32', 02:08:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:15 INFO - 'title': 'talos-linux64-ix-010', 02:08:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:15 INFO - 'use_talos_json': True, 02:08:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:15 INFO - 'work_dir': 'build'} 02:08:15 INFO - ##### 02:08:15 INFO - ##### Running clobber step. 02:08:15 INFO - ##### 02:08:15 INFO - Running pre-action listener: _resource_record_pre_action 02:08:15 INFO - Running main action method: clobber 02:08:15 INFO - rmtree: /builds/slave/test/build 02:08:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:16 INFO - Running post-action listener: _resource_record_post_action 02:08:16 INFO - ##### 02:08:16 INFO - ##### Running read-buildbot-config step. 02:08:16 INFO - ##### 02:08:16 INFO - Running pre-action listener: _resource_record_pre_action 02:08:16 INFO - Running main action method: read_buildbot_config 02:08:16 INFO - Using buildbot properties: 02:08:16 INFO - { 02:08:16 INFO - "project": "", 02:08:16 INFO - "product": "firefox", 02:08:16 INFO - "script_repo_revision": "production", 02:08:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:08:16 INFO - "repository": "", 02:08:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:08:16 INFO - "buildid": "20160417233026", 02:08:16 INFO - "pgo_build": "True", 02:08:16 INFO - "basedir": "/builds/slave/test", 02:08:16 INFO - "buildnumber": 39, 02:08:16 INFO - "slavename": "talos-linux64-ix-010", 02:08:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:08:16 INFO - "platform": "ubuntu64_hw", 02:08:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:08:16 INFO - "branch": "fx-team", 02:08:16 INFO - "repo_path": "integration/fx-team", 02:08:16 INFO - "revision": "4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8", 02:08:16 INFO - "stage_platform": "linux64-pgo", 02:08:16 INFO - "builduid": "9815e164ec184bc98272d3180d045df5", 02:08:16 INFO - "slavebuilddir": "test" 02:08:16 INFO - } 02:08:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:08:16 INFO - Running post-action listener: _resource_record_post_action 02:08:16 INFO - ##### 02:08:16 INFO - ##### Running download-and-extract step. 02:08:16 INFO - ##### 02:08:16 INFO - Running pre-action listener: _resource_record_pre_action 02:08:16 INFO - Running main action method: download_and_extract 02:08:16 INFO - mkdir: /builds/slave/test/build/tests 02:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:16 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:08:18 INFO - Downloaded 1361 bytes. 02:08:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:18 INFO - Using the following test package requirements: 02:08:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:08:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:08:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'jsshell-linux-x86_64.zip'], 02:08:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:08:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:08:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:08:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:08:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:08:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:08:18 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')]} 02:08:18 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:20 INFO - Downloaded 23774918 bytes. 02:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:08:22 INFO - Return code: 0 02:08:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:22 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:26 INFO - Downloaded 23774918 bytes. 02:08:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:08:27 INFO - Return code: 0 02:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:27 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:08:28 INFO - Downloaded 10841076 bytes. 02:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:08:28 INFO - Return code: 0 02:08: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')]} 02:08:28 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:08:30 INFO - Downloaded 58250750 bytes. 02:08:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:30 INFO - mkdir: /builds/slave/test/properties 02:08:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:30 INFO - Contents: 02:08:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:30 INFO - Running post-action listener: _resource_record_post_action 02:08:30 INFO - Running post-action listener: set_extra_try_arguments 02:08:30 INFO - ##### 02:08:30 INFO - ##### Running populate-webroot step. 02:08:30 INFO - ##### 02:08:30 INFO - Running pre-action listener: _resource_record_pre_action 02:08:30 INFO - Running main action method: populate_webroot 02:08:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:30 INFO - '--tppagecycles', 02:08:30 INFO - '7'], 02:08:30 INFO - 'tests': ['tsvgm']}}, 02:08:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['damp', 'tps']}, 02:08:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'tests': ['damp', 'tps']}, 02:08:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['dromaeo_dom']}, 02:08:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['a11yr', 02:08:30 INFO - 'ts_paint', 02:08:30 INFO - 'tpaint', 02:08:30 INFO - 'sessionrestore', 02:08:30 INFO - 'sessionrestore_no_auto_restore', 02:08:30 INFO - 'tabpaint']}, 02:08:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['tsvgx', 02:08:30 INFO - 'tsvgr_opacity', 02:08:30 INFO - 'tart', 02:08:30 INFO - 'tscrollx', 02:08:30 INFO - 'cart']}, 02:08:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:30 INFO - 'tsvgr_opacity', 02:08:30 INFO - 'tart', 02:08:30 INFO - 'tscrollx', 02:08:30 INFO - 'cart']}, 02:08:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'talos_options': ['--disable-e10s'], 02:08:30 INFO - 'tests': ['tp5o']}, 02:08:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'tests': ['tp5o']}, 02:08:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'talos_options': ['--disable-e10s', 02:08:30 INFO - '--xperf_path', 02:08:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:30 INFO - 'tests': ['tp5n']}, 02:08:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:30 INFO - 'talos_options': ['--xperf_path', 02:08:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:30 INFO - 'tests': ['tp5n']}}, 02:08:30 INFO - 'talos.zip': {'path': '', 02:08:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:30 INFO - Running post-action listener: _resource_record_post_action 02:08:30 INFO - ##### 02:08:30 INFO - ##### Running create-virtualenv step. 02:08:30 INFO - ##### 02:08:30 INFO - Running pre-action listener: _resource_record_pre_action 02:08:30 INFO - Running main action method: create_virtualenv 02:08:30 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:08:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:31 INFO - Using real prefix '/usr' 02:08:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:33 INFO - Installing pip.................done. 02:08:33 INFO - Return code: 0 02:08:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:33 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')]} 02:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:33 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')]} 02:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:33 INFO - Using env: {'DISPLAY': ':0', 02:08:33 INFO - 'HOME': '/home/cltbld', 02:08:33 INFO - 'LANG': 'en_US.UTF-8', 02:08:33 INFO - 'LANGUAGE': 'en_US:en', 02:08:33 INFO - 'LOGNAME': 'cltbld', 02:08:33 INFO - 'MAIL': '/var/mail/cltbld', 02:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:33 INFO - 'MOZ_NO_REMOTE': '1', 02:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:33 INFO - 'NO_EM_RESTART': '1', 02:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:33 INFO - 'PWD': '/builds/slave/test', 02:08:33 INFO - 'SHELL': '/bin/bash', 02:08:33 INFO - 'SHLVL': '1', 02:08:33 INFO - 'TERM': 'linux', 02:08:33 INFO - 'TMOUT': '86400', 02:08:33 INFO - 'USER': 'cltbld', 02:08:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:33 INFO - '_': '/tools/buildbot/bin/python'} 02:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:33 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 02:08:33 INFO - Cleaning up... 02:08:33 INFO - Return code: 0 02:08:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:08:33 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')]} 02:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:33 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')]} 02:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:33 INFO - Using env: {'DISPLAY': ':0', 02:08:33 INFO - 'HOME': '/home/cltbld', 02:08:33 INFO - 'LANG': 'en_US.UTF-8', 02:08:33 INFO - 'LANGUAGE': 'en_US:en', 02:08:33 INFO - 'LOGNAME': 'cltbld', 02:08:33 INFO - 'MAIL': '/var/mail/cltbld', 02:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:33 INFO - 'MOZ_NO_REMOTE': '1', 02:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:33 INFO - 'NO_EM_RESTART': '1', 02:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:33 INFO - 'PWD': '/builds/slave/test', 02:08:33 INFO - 'SHELL': '/bin/bash', 02:08:33 INFO - 'SHLVL': '1', 02:08:33 INFO - 'TERM': 'linux', 02:08:33 INFO - 'TMOUT': '86400', 02:08:33 INFO - 'USER': 'cltbld', 02:08:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:33 INFO - '_': '/tools/buildbot/bin/python'} 02:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:33 INFO - Downloading/unpacking psutil>=0.7.1 02:08:33 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 02:08:33 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 02:08:33 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 02:08:33 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 02:08:33 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 02:08:33 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 02:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:35 INFO - Installing collected packages: psutil 02:08:35 INFO - Running setup.py install for psutil 02:08:36 INFO - building 'psutil._psutil_linux' extension 02:08:36 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 02:08:36 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 02:08:36 INFO - building 'psutil._psutil_posix' extension 02:08:36 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 02:08:36 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 02:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:36 INFO - Successfully installed psutil 02:08:36 INFO - Cleaning up... 02:08:36 INFO - Return code: 0 02:08:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:08:36 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')]} 02:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:36 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')]} 02:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:36 INFO - Using env: {'DISPLAY': ':0', 02:08:36 INFO - 'HOME': '/home/cltbld', 02:08:36 INFO - 'LANG': 'en_US.UTF-8', 02:08:36 INFO - 'LANGUAGE': 'en_US:en', 02:08:36 INFO - 'LOGNAME': 'cltbld', 02:08:36 INFO - 'MAIL': '/var/mail/cltbld', 02:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:36 INFO - 'MOZ_NO_REMOTE': '1', 02:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:36 INFO - 'NO_EM_RESTART': '1', 02:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:36 INFO - 'PWD': '/builds/slave/test', 02:08:36 INFO - 'SHELL': '/bin/bash', 02:08:36 INFO - 'SHLVL': '1', 02:08:36 INFO - 'TERM': 'linux', 02:08:36 INFO - 'TMOUT': '86400', 02:08:36 INFO - 'USER': 'cltbld', 02:08:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:36 INFO - '_': '/tools/buildbot/bin/python'} 02:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:08:36 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 02:08:36 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 02:08:36 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 02:08:36 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 02:08:36 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 02:08:36 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 02:08:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:08:38 INFO - Installing collected packages: mozsystemmonitor 02:08:38 INFO - Running setup.py install for mozsystemmonitor 02:08:38 INFO - Successfully installed mozsystemmonitor 02:08:38 INFO - Cleaning up... 02:08:38 INFO - Return code: 0 02:08:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:38 INFO - Using env: {'DISPLAY': ':0', 02:08:38 INFO - 'HOME': '/home/cltbld', 02:08:38 INFO - 'LANG': 'en_US.UTF-8', 02:08:38 INFO - 'LANGUAGE': 'en_US:en', 02:08:38 INFO - 'LOGNAME': 'cltbld', 02:08:38 INFO - 'MAIL': '/var/mail/cltbld', 02:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:38 INFO - 'MOZ_NO_REMOTE': '1', 02:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:38 INFO - 'NO_EM_RESTART': '1', 02:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:38 INFO - 'PWD': '/builds/slave/test', 02:08:38 INFO - 'SHELL': '/bin/bash', 02:08:38 INFO - 'SHLVL': '1', 02:08:38 INFO - 'TERM': 'linux', 02:08:38 INFO - 'TMOUT': '86400', 02:08:38 INFO - 'USER': 'cltbld', 02:08:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:38 INFO - '_': '/tools/buildbot/bin/python'} 02:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:39 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 02:08:39 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 02:08:39 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 02:08:39 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 02:08:39 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 02:08:39 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 02:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 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 02:08:41 INFO - Downloading docopt-0.6.1.tar.gz 02:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:41 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:41 INFO - Running setup.py install for blobuploader 02:08:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:42 INFO - Running setup.py install for requests 02:08:42 INFO - Running setup.py install for docopt 02:08:42 INFO - Successfully installed blobuploader requests docopt 02:08:42 INFO - Cleaning up... 02:08:42 INFO - Return code: 0 02:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 02:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 02:08:42 INFO - Using env: {'DISPLAY': ':0', 02:08:42 INFO - 'HOME': '/home/cltbld', 02:08:42 INFO - 'LANG': 'en_US.UTF-8', 02:08:42 INFO - 'LANGUAGE': 'en_US:en', 02:08:42 INFO - 'LOGNAME': 'cltbld', 02:08:42 INFO - 'MAIL': '/var/mail/cltbld', 02:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:42 INFO - 'MOZ_NO_REMOTE': '1', 02:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:42 INFO - 'NO_EM_RESTART': '1', 02:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:42 INFO - 'PWD': '/builds/slave/test', 02:08:42 INFO - 'SHELL': '/bin/bash', 02:08:42 INFO - 'SHLVL': '1', 02:08:42 INFO - 'TERM': 'linux', 02:08:42 INFO - 'TMOUT': '86400', 02:08:42 INFO - 'USER': 'cltbld', 02:08:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:42 INFO - '_': '/tools/buildbot/bin/python'} 02:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:42 INFO - Running setup.py (path:/tmp/pip-Xeaasb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:42 INFO - Running setup.py (path:/tmp/pip-W3Z6BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:42 INFO - Running setup.py (path:/tmp/pip-TMxZdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:42 INFO - Running setup.py (path:/tmp/pip-BFRNyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:43 INFO - Running setup.py (path:/tmp/pip-gRT7HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:43 INFO - Running setup.py (path:/tmp/pip-MmuUs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:43 INFO - Running setup.py (path:/tmp/pip-l9JivR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:43 INFO - Running setup.py (path:/tmp/pip-zMnkOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:43 INFO - Running setup.py (path:/tmp/pip-g3i6aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:43 INFO - Running setup.py (path:/tmp/pip-YWqtML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:43 INFO - Running setup.py (path:/tmp/pip-POgNVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:43 INFO - Running setup.py (path:/tmp/pip-WqacGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:43 INFO - Running setup.py (path:/tmp/pip-KGNTYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:43 INFO - Running setup.py (path:/tmp/pip-e3BvkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:43 INFO - Running setup.py (path:/tmp/pip-wxxam3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:43 INFO - Running setup.py (path:/tmp/pip-cXDmRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:43 INFO - Running setup.py (path:/tmp/pip-aQd0zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:43 INFO - Running setup.py install for manifestparser 02:08:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for mozcrash 02:08:44 INFO - Running setup.py install for mozdebug 02:08:44 INFO - Running setup.py install for mozdevice 02:08:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for mozfile 02:08:44 INFO - Running setup.py install for mozhttpd 02:08:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for mozinfo 02:08:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for mozInstall 02:08:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for mozleak 02:08:44 INFO - Running setup.py install for mozlog 02:08:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:08:44 INFO - Running setup.py install for moznetwork 02:08:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Running setup.py install for mozprocess 02:08:45 INFO - Running setup.py install for mozprofile 02:08:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Running setup.py install for mozrunner 02:08:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Running setup.py install for mozscreenshot 02:08:45 INFO - Running setup.py install for moztest 02:08:45 INFO - Running setup.py install for mozversion 02:08:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:08:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:08:45 INFO - Cleaning up... 02:08:45 INFO - Return code: 0 02:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 02:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 02:08:45 INFO - Using env: {'DISPLAY': ':0', 02:08:45 INFO - 'HOME': '/home/cltbld', 02:08:45 INFO - 'LANG': 'en_US.UTF-8', 02:08:45 INFO - 'LANGUAGE': 'en_US:en', 02:08:45 INFO - 'LOGNAME': 'cltbld', 02:08:45 INFO - 'MAIL': '/var/mail/cltbld', 02:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:45 INFO - 'MOZ_NO_REMOTE': '1', 02:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:45 INFO - 'NO_EM_RESTART': '1', 02:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:45 INFO - 'PWD': '/builds/slave/test', 02:08:45 INFO - 'SHELL': '/bin/bash', 02:08:45 INFO - 'SHLVL': '1', 02:08:45 INFO - 'TERM': 'linux', 02:08:45 INFO - 'TMOUT': '86400', 02:08:45 INFO - 'USER': 'cltbld', 02:08:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:45 INFO - '_': '/tools/buildbot/bin/python'} 02:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:45 INFO - Running setup.py (path:/tmp/pip-jLm41R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:46 INFO - Running setup.py (path:/tmp/pip-xHTvyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:46 INFO - Running setup.py (path:/tmp/pip-Eeu_AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:46 INFO - Running setup.py (path:/tmp/pip-rHVhMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:46 INFO - Running setup.py (path:/tmp/pip-1uKEap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:46 INFO - Running setup.py (path:/tmp/pip-akjVZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:46 INFO - Running setup.py (path:/tmp/pip-hrKC6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:46 INFO - Running setup.py (path:/tmp/pip-Pu2FQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:46 INFO - Running setup.py (path:/tmp/pip-gK383O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:46 INFO - Running setup.py (path:/tmp/pip-aiEJZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:46 INFO - Running setup.py (path:/tmp/pip-Dzi7dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:46 INFO - Running setup.py (path:/tmp/pip-N_ZqsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:46 INFO - Running setup.py (path:/tmp/pip-GjuCz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:46 INFO - Running setup.py (path:/tmp/pip-Z3H5qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:46 INFO - Running setup.py (path:/tmp/pip-9O87R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:47 INFO - Running setup.py (path:/tmp/pip-6WZJjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:47 INFO - Running setup.py (path:/tmp/pip-ICgrdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:47 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 02:08:47 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 02:08:47 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 02:08:47 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 02:08:47 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 02:08:47 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 02:08:49 INFO - Downloading blessings-1.6.tar.gz 02:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:49 INFO - Installing collected packages: blessings 02:08:49 INFO - Running setup.py install for blessings 02:08:49 INFO - Successfully installed blessings 02:08:49 INFO - Cleaning up... 02:08:49 INFO - Return code: 0 02:08:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:49 INFO - Reading from file tmpfile_stdout 02:08:49 INFO - Current package versions: 02:08:49 INFO - argparse == 1.2.1 02:08:49 INFO - blessings == 1.6 02:08:49 INFO - blobuploader == 1.2.4 02:08:49 INFO - docopt == 0.6.1 02:08:49 INFO - manifestparser == 1.1 02:08:49 INFO - mozInstall == 1.12 02:08:49 INFO - mozcrash == 0.17 02:08:49 INFO - mozdebug == 0.1 02:08:49 INFO - mozdevice == 0.48 02:08:49 INFO - mozfile == 1.2 02:08:49 INFO - mozhttpd == 0.7 02:08:49 INFO - mozinfo == 0.9 02:08:49 INFO - mozleak == 0.1 02:08:49 INFO - mozlog == 3.1 02:08:49 INFO - moznetwork == 0.27 02:08:49 INFO - mozprocess == 0.22 02:08:49 INFO - mozprofile == 0.28 02:08:49 INFO - mozrunner == 6.11 02:08:49 INFO - mozscreenshot == 0.1 02:08:49 INFO - mozsystemmonitor == 0.0 02:08:49 INFO - moztest == 0.7 02:08:49 INFO - mozversion == 1.4 02:08:49 INFO - psutil == 3.1.1 02:08:49 INFO - requests == 1.2.3 02:08:49 INFO - wsgiref == 0.1.2 02:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 02:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 02:08:49 INFO - Using env: {'DISPLAY': ':0', 02:08:49 INFO - 'HOME': '/home/cltbld', 02:08:49 INFO - 'LANG': 'en_US.UTF-8', 02:08:49 INFO - 'LANGUAGE': 'en_US:en', 02:08:49 INFO - 'LOGNAME': 'cltbld', 02:08:49 INFO - 'MAIL': '/var/mail/cltbld', 02:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:49 INFO - 'MOZ_NO_REMOTE': '1', 02:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:49 INFO - 'NO_EM_RESTART': '1', 02:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:49 INFO - 'PWD': '/builds/slave/test', 02:08:49 INFO - 'SHELL': '/bin/bash', 02:08:49 INFO - 'SHLVL': '1', 02:08:49 INFO - 'TERM': 'linux', 02:08:49 INFO - 'TMOUT': '86400', 02:08:49 INFO - 'USER': 'cltbld', 02:08:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:49 INFO - '_': '/tools/buildbot/bin/python'} 02:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:08:49 INFO - Cleaning up... 02:08:49 INFO - Return code: 0 02:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:49 INFO - Using env: {'DISPLAY': ':0', 02:08:49 INFO - 'HOME': '/home/cltbld', 02:08:49 INFO - 'LANG': 'en_US.UTF-8', 02:08:49 INFO - 'LANGUAGE': 'en_US:en', 02:08:49 INFO - 'LOGNAME': 'cltbld', 02:08:49 INFO - 'MAIL': '/var/mail/cltbld', 02:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:49 INFO - 'MOZ_NO_REMOTE': '1', 02:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:49 INFO - 'NO_EM_RESTART': '1', 02:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:49 INFO - 'PWD': '/builds/slave/test', 02:08:49 INFO - 'SHELL': '/bin/bash', 02:08:49 INFO - 'SHLVL': '1', 02:08:49 INFO - 'TERM': 'linux', 02:08:49 INFO - 'TMOUT': '86400', 02:08:49 INFO - 'USER': 'cltbld', 02:08:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:49 INFO - '_': '/tools/buildbot/bin/python'} 02:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:49 INFO - Downloading/unpacking jsonschema 02:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:51 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:51 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:52 INFO - warning: no files found matching '*.txt' 02:08:52 INFO - no previously-included directories found matching 'build' 02:08:52 INFO - no previously-included directories found matching 'dist' 02:08:52 INFO - no previously-included directories found matching '.git*' 02:08:52 INFO - Installing collected packages: jsonschema, functools32 02:08:52 INFO - Running setup.py install for functools32 02:08:52 INFO - warning: no files found matching '*.txt' 02:08:52 INFO - no previously-included directories found matching 'build' 02:08:52 INFO - no previously-included directories found matching 'dist' 02:08:52 INFO - no previously-included directories found matching '.git*' 02:08:52 INFO - Successfully installed jsonschema functools32 02:08:52 INFO - Cleaning up... 02:08:52 INFO - Return code: 0 02:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8847f12f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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/build 02:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:08:52 INFO - Using env: {'DISPLAY': ':0', 02:08:52 INFO - 'HOME': '/home/cltbld', 02:08:52 INFO - 'LANG': 'en_US.UTF-8', 02:08:52 INFO - 'LANGUAGE': 'en_US:en', 02:08:52 INFO - 'LOGNAME': 'cltbld', 02:08:52 INFO - 'MAIL': '/var/mail/cltbld', 02:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:52 INFO - 'MOZ_NO_REMOTE': '1', 02:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:52 INFO - 'NO_EM_RESTART': '1', 02:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:52 INFO - 'PWD': '/builds/slave/test', 02:08:52 INFO - 'SHELL': '/bin/bash', 02:08:52 INFO - 'SHLVL': '1', 02:08:52 INFO - 'TERM': 'linux', 02:08:52 INFO - 'TMOUT': '86400', 02:08:52 INFO - 'USER': 'cltbld', 02:08:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:52 INFO - '_': '/tools/buildbot/bin/python'} 02:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:52 INFO - Downloading/unpacking flake8 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:55 INFO - no previously-included directories found matching 'docs/_build' 02:08:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:55 INFO - Running setup.py install for pep8 02:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:55 INFO - no previously-included directories found matching 'docs/_build' 02:08:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:55 INFO - Cleaning up... 02:08:55 INFO - Return code: 0 02:08:55 INFO - Running post-action listener: _resource_record_post_action 02:08:55 INFO - Running post-action listener: _start_resource_monitoring 02:08:55 INFO - Starting resource monitoring. 02:08:55 INFO - ##### 02:08:55 INFO - ##### Running install step. 02:08:55 INFO - ##### 02:08:55 INFO - Running pre-action listener: _resource_record_pre_action 02:08:55 INFO - Running main action method: install 02:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:55 INFO - Reading from file tmpfile_stdout 02:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:55 INFO - Reading from file tmpfile_stdout 02:08:55 INFO - Output received: 02:08:55 INFO - Usage: mozinstall [options] installer 02:08:55 INFO - Options: 02:08:55 INFO - -h, --help show this help message and exit 02:08:55 INFO - -d DEST, --destination=DEST 02:08:55 INFO - Directory to install application into. [default: 02:08:55 INFO - "/builds/slave/test"] 02:08:55 INFO - --app=APP Application being installed. [default: firefox] 02:08:55 INFO - mkdir: /builds/slave/test/build/application 02:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:09:12 INFO - Reading from file tmpfile_stdout 02:09:12 INFO - Output received: 02:09:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:09:12 INFO - Running post-action listener: _resource_record_post_action 02:09:12 INFO - ##### 02:09:12 INFO - ##### Running run-tests step. 02:09:12 INFO - ##### 02:09:12 INFO - Running pre-action listener: _resource_record_pre_action 02:09:12 INFO - Running main action method: run_tests 02:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:12 INFO - Python 2.7.3 02:09:12 INFO - Return code: 0 02:09:12 INFO - grabbing minidump binary from tooltool 02:09:12 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')]} 02:09:12 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/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 0x297b810>, '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 0x297c710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x297cba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:09:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:09:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:12 INFO - Return code: 0 02:09:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:09:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:09:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:09:13 INFO - Return code: 0 02:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:09:13 INFO - Using env: {'DISPLAY': ':0', 02:09:13 INFO - 'HOME': '/home/cltbld', 02:09:13 INFO - 'LANG': 'en_US.UTF-8', 02:09:13 INFO - 'LANGUAGE': 'en_US:en', 02:09:13 INFO - 'LOGNAME': 'cltbld', 02:09:13 INFO - 'MAIL': '/var/mail/cltbld', 02:09:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:13 INFO - 'MOZ_NO_REMOTE': '1', 02:09:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:13 INFO - 'NO_EM_RESTART': '1', 02:09:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:13 INFO - 'PWD': '/builds/slave/test', 02:09:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:13 INFO - 'SHELL': '/bin/bash', 02:09:13 INFO - 'SHLVL': '1', 02:09:13 INFO - 'TERM': 'linux', 02:09:13 INFO - 'TMOUT': '86400', 02:09:13 INFO - 'USER': 'cltbld', 02:09:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968', 02:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:13 INFO - '_': '/tools/buildbot/bin/python'} 02:09:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:09:13 INFO - mozversion application_buildid: 20160417233026 02:09:13 INFO - mozversion application_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 02:09:13 INFO - mozversion application_display_name: Nightly 02:09:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:13 INFO - mozversion application_name: Firefox 02:09:13 INFO - mozversion application_remotingname: firefox 02:09:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:09:13 INFO - mozversion application_vendor: Mozilla 02:09:13 INFO - mozversion application_version: 48.0a1 02:09:13 INFO - mozversion platform_buildid: 20160417233026 02:09:13 INFO - mozversion platform_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 02:09:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:09:13 INFO - mozversion platform_version: 48.0a1 02:09:13 INFO - using testdate: 1460970553 02:09:13 INFO - actual date: 1460970553 02:09:13 INFO - starting webserver on 'localhost:35799' 02:09:13 INFO - SUITE-START | Running 2 tests 02:09:13 INFO - TEST-START | dromaeo_css 02:09:13 INFO - operating with platform_type : linux_ 02:09:13 INFO - Initialising browser for dromaeo_css test... 02:09:13 INFO - TEST-INFO | started process 31456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJiVJDF/profile http://localhost:35799/getInfo.html) 02:09:18 INFO - PROCESS | 31456 | __metrics Screen width/height:1600/1200 02:09:18 INFO - PROCESS | 31456 | colorDepth:24 02:09:18 INFO - PROCESS | 31456 | Browser inner width/height: 1024/697 02:09:18 INFO - PROCESS | 31456 | __metrics 02:09:19 ERROR - PROCESS | 31456 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:09:20 INFO - TEST-INFO | 31456: exit 0 02:09:20 INFO - Browser initialized. 02:09:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:20 INFO - TEST-INFO | started process 31537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJiVJDF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:32 INFO - PROCESS | 31537 | RSS: Main: 153808896 02:09:32 INFO - PROCESS | 31537 | 02:10:23 INFO - PROCESS | 31537 | 1460970623043 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] 02:12:30 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35799/tests/dromaeo/cssquery-ext.html) 02:12:31 INFO - PROCESS | 31537 | RSS: Main: 251523072 02:12:31 INFO - PROCESS | 31537 | 02:15:33 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-ext.html (next: http://localhost:35799/tests/dromaeo/cssquery-jquery.html) 02:15:34 INFO - PROCESS | 31537 | RSS: Main: 233877504 02:15:34 INFO - PROCESS | 31537 | 02:18:36 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35799/tests/dromaeo/cssquery-mootools.html) 02:18:36 INFO - PROCESS | 31537 | RSS: Main: 234024960 02:18:36 INFO - PROCESS | 31537 | 02:21:38 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35799/tests/dromaeo/cssquery-prototype.html) 02:21:39 INFO - PROCESS | 31537 | RSS: Main: 232423424 02:21:39 INFO - PROCESS | 31537 | 02:24:41 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35799/tests/dromaeo/cssquery-yui.html) 02:24:42 INFO - PROCESS | 31537 | RSS: Main: 223870976 02:24:42 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | Cycle 1(1): loaded http://localhost:35799/tests/dromaeo/cssquery-yui.html (next: http://localhost:35799/tests/dromaeo/cssquery-dojo.html) 02:27:45 INFO - PROCESS | 31537 | RSS: Main: 266633216 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | __start_tp_report 02:27:45 INFO - PROCESS | 31537 | _x_x_mozilla_page_load 02:27:45 INFO - PROCESS | 31537 | _x_x_mozilla_page_load_details 02:27:45 INFO - PROCESS | 31537 | |i|pagename|runs| 02:27:45 INFO - PROCESS | 31537 | |0;dojo.html;3099.5505651680505;3127.0931429885336;3154.7949383290083;3161.7944833585802;3196.392685389775;5227.843164705056;5236.083685355066;5268.157094864818;5293.523582877545;5342.145256758915;5301.363836339645;5323.9467605323935;5327.520523152915;5328.653637513559;5391.757370918308;4780.78486468108;4828.710277383359;4893.29047288143;4921.655484116113;4972.726500042496;4884.926726099094;4908.705477671333;4911.23641919703;4916.803327866899;4919.434265059528;4716.363290955728;4753.976230118862;4774.570288674018;4779.426468823729;4895.7062576245535;4762.952370476286;4772.880677983078;4780.498047704976;4782.665213435061;4811.278308253755;4726.125666751627;4764.8332308369045;4779.784909679072;4793.599234777769;4796.9760151199025;5119.180931051014;5142.7685754140775;5162.380514338266;5216.426193118754;5225.2162175673575;5613.410591887875;5641.323041235037;5644.181593668936;5650.3219613646215;5655.462731040545;5469.644473109275;5590.413006634326;5639.295088113986;5672.4611161939965;5689;5259.76331065103;5259.86850328741;5262.92105618416;5265.710385928773;5325.840224793263;5716.828495145069;5743.885122297531;5753.942460575425;5765.019946609086;5773.6824474654295;5371.516563509303;5454.372747134051;5497.147942068986;5522.061249587579;5538.723063846872;5566.332040155207;5571.888562228733;5583;5586.13414920688;5597.692126933058;5551.333839939233;5552.91670624941;5554.50009499147;5555.3333599967455;5570.526505247019;5468.671879687152;5528.253685752372;5596.804111856066;5630.97184514083;5631.521320687705;4272.807723652443;4273.829046838154;4276.294411422143;4277;4320.330348795942;3814.694824414096;3865.729398942047;3868.6518213360932;3892.0464486200494;3893.902652433655;5218.269442278084;5301.443348448434;5342.652727572696;5370.704611246419;5375.3012108425655;5542.8337149885565;5543.057680194376;5544.140658197985;5551.861203469864;5552.6668399895325;5162.1224391853475;5207.297014903015;5229.555487783505;5234.450382709761;5269.077911365495;4838.080764654705;4902.926456103161;4909.459959404463;4928.989557140778;4929.211326187793;5756.65460072397;5778.335491418541;5782.59521833476;5788.507976821933;5806.158107074535;5490.5882058844945;5623.268975033301;5635.971820140873;5650.886982260249;5695.772169113189;5727.770889164553;5754.597178197486;5781.624194427349;5797.652140871562;5843.094320380348;5486.807961721321;5490.670559766267;5503.3395992481155;5504.422035686195;5505;5467.781288748405;5528.861778455571;5576.609637325349;5584.832455026356;5592.3009623797025;5423.213634022965;5450.700211488248;5458.099413596712;5467.972660136674;5511.090670039399;5402.297701298806;5407.540359069366;5433.5924805640525;5434.83695489136;5497.312835895513;5319.095753721954;5344.038073146871;5374.355077390738;5423.430539793423;5488.753006114654;5474.507294343369;5482.23248745184;5484.149956756709;5489.5608351331;5528.032594295902;5359.892802143857;5371.731413429235;5376.946230537645;5380.488853558905;5420.186971954238 02:27:45 INFO - PROCESS | 31537 | |1;ext.html;609.8383928259009;646.9482441404688;650.1093501902393;661.4774328280662;662.5461558832201;29230;30016.699833001665;37104.257914841684;37361.813190934074;37632;39952.200955980865;40751.38872916901;40861.59138408615;41030.589694103124;41058.99999999993;8386.790330241747;8576.313894888424;8580.356473264499;8582.613782379807;8585.527795971218;7856.7642970710685;10085;10383.376997380143;10391.064804167623;10399.272050956437;10023.298369114165;10106.039926207035;10111.342762720436;10111.595536178544;10116.848247276297;7895.802604934923;9980.600775968953;10108.646197383094;10108.64619738313;10117.291789574732;9952.452615106165;10120.544575494047;10120.898791012069;10123;10124.797504049951;40021.59978400208;40604.39093413601;40729.59270407288;40843.18313633711;40976.38535421971;3287.7862938908893;3424.434968230239;3545.6986156176754;3860.749051311656;4026.6376026157495;31366;31485.212869678442;31874;31899.202519936956;32346.6765332346;4272.5086615039045;4276.080642661843;4311.612443363343;4364.650827933758;4415.028693687384;299228;299910.00899910054;303922;304795;304916;35427.11432214215;36240.81879590585;57851.4214857846;58115;58402;34326.14184645404;34355.82822085873;34556.88987991093;34558.136046598534;34595.65404345975;15054.623634409008;15192.240387980777;15263.313150908014;15286.694266114615;15288.847111528965;12214.75570488603;12224.26654400721;12233.143679942497;12276.202046866925;12276.693082673004;8552.230299272971;8559.315254779603;8594.140585941355;8651.783705407415;8660.8700869487;3278.0821370016433;3317.374486501645;3331.4170020246843;3346.899593012165;3359.177001634615;912.2200518556671;1107.6566264458045;1122.7810576937582;1180.8582970043649;1226.3132645718426;28822.567661485093;29646.851765741034;29652.258693532833;30112;30227.697723022487;1108.8613923259593;1129.1192869561755;1144.4849817581955;1153.8153895376868;1205.9095567832449;15784.842151578338;16423.589410264838;16610.50168494947;17130.743038854427;17179.57051073708;444278;446032;449852;449928;450750;56195.43804561902;57010.71494642583;57350.13974790381;57414.7129264351;57514.424855750905;1303.7066660001612;1411.7600007998665;1445.4218312675014;1459.4162335065846;1546.9789938640442;28227.15318540447;29467.705322946495;29778.553321699757;29853.701462985962;30510.237244069074;41633.79183104065;41891.37162942619;42178.789106054275;42356;42400.57599423966;215729;216602;216936;217013;217102;25353.74646253514;27511.449771004867;27525;27836.582451262842;27973.300667483476;39381;40949.59050409458;40980.3852942212;41246.793766030976;41922.58077419187;39447.605523944396;39461.60538394694;39769;40429.595704042586;42817.78591107025;38233.23533529369;39009.41485877771;39358.21283574255;39495.210095797345;39882.80058599688;39913.401298981116;40115;42688.35967460428;43593.346099807895;43700;33073.173170670925;35294.47058294076;35555.11112222112;35748.28503429865;35955.280894382486;27880.302992425353;28272.575911360935;28311.575326369708;28327;28348.433031338845 02:27:45 INFO - PROCESS | 31537 | |2;jquery.html;385.8732501096797;387.96120387961207;388.3882884456979;397.92041591681664;405.55794184339067;14361.35373908174;14979.325930333134;17780.555486112837;18334.541636459096;18338.174782134804;14478.565643030699;16832.074235917018;17011;17645.00034994051;17680.292788288454;5286.365636123661;5700.258966334371;5703.714814259291;5707.315122185323;5710;4053.3312003519386;5600.887982240352;5676.148577713335;5681.630694004897;5901.321348044966;6133.44798968095;6153.200083989098;6166.568340216187;6167.136600875881;6188.876222475547;5984.670843103606;6073.240844894388;6134.631922084667;6163.87672246557;6177.733564619287;5442.700651464168;5442.727863606804;5452.59105567084;5461.644993075477;5478.863028424282;20168.394948151577;20932.267370641955;21599.35201943944;21629.567408651896;21806.563868722536;2390.6533552634946;2391.2228525729033;2426.551088048717;2533.2147034419204;2593.7679602188996;13364.198148111145;13946;13995.160290382508;14008.299585020708;14205.644858878508;1859.33064096925;1906.713992901062;1964.6856502959602;1976.5651556657513;2033.9389818305326;74562;76447.23552764513;76468.7354701308;77734;79247.60376198082;9803.411795292306;10154;10202.846957295647;10298.3820970742;10301.175905927508;14188.219647919257;14212.644683882985;14309.069910455786;14319.713605727828;14341;7065.43476521877;7275.818104547428;7587.165411804697;7626.122995855437;7646.808829779189;7942.245486678757;8029.678812847421;8093.231143041402;8095.554744488992;8102.149274326111;6067.332593414721;6284.340144284875;6349.6507692077375;6353.682315884187;6357.7139028742895;1714.3451369941083;1855.1448551448552;1870.7568016157813;1881.0500697147852;1945.3094151575988;898.4833720610675;952.5903861339552;976.5215044628081;1009.4700282351824;1017.9694609161737;17149.228284727218;17451.82548174502;17706.46880593584;17859.46421607354;18453.1696073677;947.8246524392871;986.2405947420447;1009.4851625670814;1011.3476807459294;1022.2282176956351;9070.818583628423;9592.712218633313;9614.173307071635;9678;9770.12068913787;468784;472335;472836;473856;477914;93807;94292;94711;95688;97387.51306243423;1063.1335461598771;1072.6084978982615;1082.0640146273417;1087.2226358153957;1105.2042529378673;14975.251237438302;15084.924575377492;15152;15221.695566088394;15385.922985390915;33638.32723345568;35055.64944350524;35471.64528354786;35511.82244088763;35735;37827.62172378241;44542.3318650227;52718.73640631772;56719.432805671415;57700;5050.191969284897;6208.906866397098;6652.800415987528;7527.887081693889;7841.960790196013;8738.388312818295;11821.822672659744;12704.428300726304;12766.234025958473;12784;10857.13142948578;11160.944195278971;11392.430378480876;11489.827652585385;11531.481083351102;10908.781824363627;11044.779104418027;11231.26996745209;11257.986781189733;11437.885621143681;10701.785964280514;10960.451977401257;10992.395418252074;11279.32324060559;11322.207445478738;7747.147813740371;7765.1846556110795;7812;7983.401244906771;8120.309773669304;10467.738306542398;11216.102711782874;11347.659570212907;11386.544538218379;11422.714432139262 02:27:45 INFO - PROCESS | 31537 | |3;mootools.html;1311.0363882546321;1450.6373406648338;1491.0829839648616;1607.5177446765967;1826.58901747107;7700.576468294242;8546.786330341745;8747.300215982723;8804.603792829323;8809.295256379482;8035.879461808077;8143.144969778177;8193.426460147792;8201.425900186974;8210.178982101786;1991.7211590377358;2184.715986921698;2255.4699645583273;2256.0750092462094;2286.2569664858906;2301.1945818963395;2311.318161142467;2314.7916687498123;2319.5940710375703;2321.6401457774073;2231.6540936154843;2248.7301523817164;2251.167068184766;2253.808426283768;2260.5026894083276;1963.1460314763053;2143.7641859395453;2202.383332666856;2209.028027667821;2210.5910406574835;2128.4040468668795;2135.839812014105;2139.1657253671083;2139.796719311663;2188.6826410170597;8606.139386061406;8626.051134375213;8706.259967902735;8716.607752651145;8723.084076171974;4897.902041959176;5020.1214787412055;5022.1211288024815;5057.291979122926;5059.569936555397;3142.6228852537615;3174.6349169845535;3212.4860022396306;3240.4815229563155;3279.376918385523;1032.3238278927315;1043.1341986151476;1046.3878631000873;1046.502911117221;1067.4769363012147;11863.762724745544;11969.581064662694;11998.820017699654;12024.69938251542;12047.638570842888;4153.460050193456;4220.831166753295;4333;4337.503561271356;4354.216241076637;9957.601695932082;9982.251331150193;10011.79976400468;10018;10037.146842518321;4585.426821647294;4956.256561515729;4973.676711013845;4990.725510096907;5004.524570165829;4407.757573333433;4490.797914093873;4493.348464472633;4502.662300327489;4519.977400112978;3772.3775577030033;3839.6928245740273;3897.7466464679705;4043.130726893732;4069.04377471294;1248.6836917518056;1269.0672355818467;1276.8403949506312;1277.9297138657464;1278.239447528719;908.5457271364318;957.2533423929347;1002.6139936124645;1021.6832781837505;1025.3027941000191;6014.72933717975;6038.758449662052;6125.9693701531205;6130.509559235251;6199.907001394983;407.96532294754684;411.1140492239229;412.5152945289333;973.7808992976524;1000.3597697473623;3913.4325522799604;3967.26605577969;3977.2244412339896;3995.9800200998807;3998.9800051000143;10375.63685271027;10576.735581610521;10853.565857365775;10880.020798128206;10917.017468427879;10599.417032063157;10604.628837990633;10623.84064239037;10753.892461075446;10817.621383251548;7962.522248665098;7964.960175199087;8023.598820058974;8040.959795201104;8134.918650813416;5841.065429531254;5942.851428714317;5943.435373639497;6033.12519684652;6066.393360663898;9417.199538039069;9478.478683672463;9530.85703714431;9630.759231019281;9680.75798105053;9352.485613291334;9728.951355243178;9860.260480464138;9929.205663546754;9944.701658950244;6851.246362900177;7034.437245020284;7063.081799366049;7199.532030418006;7306.853862922818;8056.194380562131;8278.213569710868;8285.627146778288;8289.129641387568;8297.460665056751;7257.346838784323;7270.163931147986;7394.593297368697;7506.437017223621;7525;7191.604461754445;7218.494705370574;7371.4102871769055;7379.704811807467;7448.068991376078;6832.59004459734;6897.3447522485285;6907.205671347659;6917.827054323481;6933.618650974245;4806.8798280043275;4956.3804524434445;4960.379952505937;4987.202047672355;5061.898762024813;5093.71984540839;5159.948400515947;5160.406553246275;5293.576513878804;5323.121684922099 02:27:45 INFO - PROCESS | 31537 | |4;prototype.html;315.4763093265179;317.52529967698297;323.3855674218982;325.6694455128045;331.7478716175706;5504.256925315081;5668.57485688574;5677;5698.005698005702;5815.592908496402;5666.858328541778;5751.769929202837;5767.394423585526;5773.249477567921;5808.273965754281;4467.9329810052795;4470.195364834329;4475.552444755531;4477.082198149372;4487.461504619434;4418.826153686727;4481.484629267643;4481.507034226249;4490.41624588803;4491.550844915499;4410.16206920684;4424.513303536608;4426.86719398417;4434.68957172998;4436.44544431946;4365.5416181300825;4387.3857659927635;4417.845375411877;4443.400140980974;4444.377787109791;3778.9433158502643;3869.903252418712;3871.9612803871883;3886.650201481852;3902.941455878164;5542.806001789918;5545.423202034665;5547;5558.527525160366;5565.193047008162;5071.923921141186;5107.3360463139925;5111.08000559899;5117.974410127926;5120.308758317617;5797;6021.163545118737;6040.365761595057;6045.825941380766;6054.545909056838;4262.7655478948645;4272.9145417091795;4276.87169384919;4276.914461710749;4280.357946308079;6296.685165741695;6313.431791138773;6314.989601663758;6318.652474113922;6321.083442900754;4065.288574499451;4237.851675191354;4266.957330426718;4278.529361770203;4403.84586539476;4279.122779830127;4291.849785257501;4295.613394794484;4300.7634580097765;4334.5882141196535;4990.525900039491;5007.574356179693;5026.29631851541;5027.748612569357;5032.3961124665275;5766.654000759968;5850.444207800252;5954.166416701665;6065.484433823086;6091.299500557404;1467.0977348930544;1489.6127006978263;1490.9627259318604;1493.5668656089829;1494.5292232946588;980.5734505490135;989.9010098990043;1002.6290272599039;1007.9596816127273;1010.8938561451089;5764;5795.971020144957;5820.854478637983;5822.767089316465;5859.267591551056;6145.96927015371;6157.168782214344;6175.876482470326;6178.876422471525;6211.689415529206;5569;5766.365699773021;5794.797182098607;5820.912686309709;5822.359540450547;3238.3847069057274;3287.260366417585;3302.78531895426;3309.635940046593;3328.56728625282;6275.717592708339;6302.4958003359625;6388.201474815648;6425.807225783234;6444.742210311629;6296.905546416808;6309.14826498426;6315.526335524854;6318.304986451487;6334.429901308904;6144.78493252734;6409.487241020707;6414.743410263537;6415.824167037346;6435.2599451063725;6128.63228206309;6139.145297436535;6173.722182501709;6213.720382582705;6219.414049417551;6106.664133472702;6130.854201029604;6136.2636483622255;6142.508599311955;6153.5692501526255;6176.845578860564;6303.810885673437;6378.936210637834;6411.743530258737;6416;4257.5529569396;4267.231898258343;4276.123394704016;4285.528591854956;4290.849820256276;5829.697269578577;5954.851128721643;6176.567640265138;6188.164597779242;6202.069689546604;6065.3934606539;6073.514118870568;6107.633541987495;6115.908261376172;6123.785667501616;6055.333913269449;6074;6100.420460056288;6106.511479081574;6113.2969708482315;5877.441643043904;5967.492763115184;6008.8798224036145;6009.789657361971;6032.1856549365275;6079.635221886701;6096.177016102769;6097.207363042776;6120.938790612036;6133.60131591463;5837.824865254049;5887.852803679943;5970.194023806731;5986.700664966821;5988.610740301867 02:27:45 INFO - PROCESS | 31537 | |5;yui.html;829.1206251211618;832.5421018439856;838.1702114906241;842.397685654757;851.64656667483;13140.14589051711;13205.801912971288;13355.732885342288;13363.198208107508;13405.262710550916;12595.181313214634;12703.428345724442;12734.172278801894;12756.808647870266;13338.866611333884;694.6526736631685;792.5205250823255;831.193742070191;834.6452757578036;841.032812265896;824.8968878890139;833.7998880268722;834.5159807311744;835.5696816139692;835.678263868412;854.372036553133;861.0915484164204;864.2135656552507;865.1867244789877;865.8138500222451;720.531654424623;837.3426859914938;859.1065292096213;861.7759382560516;862.1637012098255;619.5013014523307;622.4584611388121;622.8007037747923;624.2010226909563;625.1903784598956;13821.930890345584;13849.238291893942;13857.722845543134;13881.305934703225;13889.583312500641;12775.23348599087;12961.41673624689;13150.802737958938;13211.669708257274;13397.799033014513;10997.285176463503;11157.776844463146;11485.138614603939;11513.481893314822;11621.418929053514;3779.7543159694533;3798.4302354647025;3801.581825999138;3851.5185601799776;3851.9422208666892;54656.45343546553;54699.45300547023;54791.72604136993;54794.452055479334;54799.72600136974;10352.792944141225;10534.789304214026;10558.788824223473;10778.19163562736;10818.404987725751;18798.718019229724;18890.622187556448;18930.43208703741;19244.71132933007;19268;8037.196280371916;8044.879326810103;8110.026796784306;8117.350611951029;8187.7134300300395;4759.143354196209;4810.230363141881;4869.683470574401;4908.730019848943;4934.605231581465;3298.719608833276;3413.795172289621;3430.622631510532;3440.569928758905;3442.4147894857933;596.9194158788508;601.3415310235285;609.7713357490941;612.9908051379233;613.089562000429;754.607604045904;771.9691212351443;777.3547955197173;782.6008735544913;819.3772732723054;8960;8961.955190224138;9030.593623286968;9118.95440522793;9160.770980725536;596.6241268001131;707.7876637008877;746.6677328588835;747.704656660616;760.1551983529918;4484.0583477469445;4540.477845047862;4563.634909207255;4565.429321334833;4625.352450656911;60900.69549652223;61378.079328810105;61395;61879.38120618826;62323.688381557804;53468.46531534635;53644.19533706998;54011.45988540064;54444.183337249975;54988;49229.261561076615;50062.49937500651;50163.49836501661;50204.49795502071;50697.74651126721;8703.695370661997;8724;8803.867941981003;8868.733937981871;8875.955620221857;32169.517457238628;32417.35165296728;32618.184545386554;32677.673223267462;32768.50847237341;40962.79518602388;44289.33565996577;44753.32870006887;45044.32433513566;45411.545884540734;10844.891551084389;11211.495482703462;11212.49543770516;12265.754684906431;12336.876631233932;13333.133346332457;13612.319384030958;13979.99177472672;14016.509422170175;14283.571492855232;12192.756144876876;12436.067294953096;13007.219566826021;13123.54067607629;13550.390232439368;13323.66690832737;13413.530526431528;13489.460421583419;13534.79697804514;14153.938454616151;12409.565665201675;12540.811887821508;12588.748225035632;12732.87267127317;13454.192748435125;11000.449977501254;11185.720356990814;11415.258008229439;11419.543218271509;11454.94272528632;10832.133429325793;11005.889941100806;11274.60538881168;11319.717007074889;11362.375069371265 02:27:45 INFO - PROCESS | 31537 | __end_tp_report 02:27:45 INFO - PROCESS | 31537 | __start_cc_report 02:27:45 INFO - PROCESS | 31537 | _x_x_mozilla_cycle_collect,785 02:27:45 INFO - PROCESS | 31537 | __end_cc_report 02:27:45 INFO - PROCESS | 31537 | __startTimestamp1460971665380__endTimestamp 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | ------- Summary: start ------- 02:27:45 INFO - PROCESS | 31537 | Number of tests: 6 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#0] dojo.html Cycles:165 Average:5213.74 Median:5391.76 stddev:561.53 (10.4%) stddev-sans-first:538.20 02:27:45 INFO - PROCESS | 31537 | Values: 3099.6 3127.1 3154.8 3161.8 3196.4 5227.8 5236.1 5268.2 5293.5 5342.1 5301.4 5323.9 5327.5 5328.7 5391.8 4780.8 4828.7 4893.3 4921.7 4972.7 4884.9 4908.7 4911.2 4916.8 4919.4 4716.4 4754.0 4774.6 4779.4 4895.7 4763.0 4772.9 4780.5 4782.7 4811.3 4726.1 4764.8 4779.8 4793.6 4797.0 5119.2 5142.8 5162.4 5216.4 5225.2 5613.4 5641.3 5644.2 5650.3 5655.5 5469.6 5590.4 5639.3 5672.5 5689.0 5259.8 5259.9 5262.9 5265.7 5325.8 5716.8 5743.9 5753.9 5765.0 5773.7 5371.5 5454.4 5497.1 5522.1 5538.7 5566.3 5571.9 5583.0 5586.1 5597.7 5551.3 5552.9 5554.5 5555.3 5570.5 5468.7 5528.3 5596.8 5631.0 5631.5 4272.8 4273.8 4276.3 4277.0 4320.3 3814.7 3865.7 3868.7 3892.0 3893.9 5218.3 5301.4 5342.7 5370.7 5375.3 5542.8 5543.1 5544.1 5551.9 5552.7 5162.1 5207.3 5229.6 5234.5 5269.1 4838.1 4902.9 4909.5 4929.0 4929.2 5756.7 5778.3 5782.6 5788.5 5806.2 5490.6 5623.3 5636.0 5650.9 5695.8 5727.8 5754.6 5781.6 5797.7 5843.1 5486.8 5490.7 5503.3 5504.4 5505.0 5467.8 5528.9 5576.6 5584.8 5592.3 5423.2 5450.7 5458.1 5468.0 5511.1 5402.3 5407.5 5433.6 5434.8 5497.3 5319.1 5344.0 5374.4 5423.4 5488.8 5474.5 5482.2 5484.1 5489.6 5528.0 5359.9 5371.7 5376.9 5380.5 5420.2 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#1] ext.html Cycles:180 Average:47959.39 Median:34340.99 stddev:88943.54 (259.0%) stddev-sans-first:89122.00 02:27:45 INFO - PROCESS | 31537 | Values: 609.8 646.9 650.1 661.5 662.5 29230.0 30016.7 37104.3 37361.8 37632.0 39952.2 40751.4 40861.6 41030.6 41059.0 8386.8 8576.3 8580.4 8582.6 8585.5 7856.8 10085.0 10383.4 10391.1 10399.3 10023.3 10106.0 10111.3 10111.6 10116.8 7895.8 9980.6 10108.6 10108.6 10117.3 9952.5 10120.5 10120.9 10123.0 10124.8 40021.6 40604.4 40729.6 40843.2 40976.4 3287.8 3424.4 3545.7 3860.7 4026.6 31366.0 31485.2 31874.0 31899.2 32346.7 4272.5 4276.1 4311.6 4364.7 4415.0 299228.0 299910.0 303922.0 304795.0 304916.0 35427.1 36240.8 57851.4 58115.0 58402.0 34326.1 34355.8 34556.9 34558.1 34595.7 15054.6 15192.2 15263.3 15286.7 15288.8 12214.8 12224.3 12233.1 12276.2 12276.7 8552.2 8559.3 8594.1 8651.8 8660.9 3278.1 3317.4 3331.4 3346.9 3359.2 912.2 1107.7 1122.8 1180.9 1226.3 28822.6 29646.9 29652.3 30112.0 30227.7 1108.9 1129.1 1144.5 1153.8 1205.9 15784.8 16423.6 16610.5 17130.7 17179.6 444278.0 446032.0 449852.0 449928.0 450750.0 56195.4 57010.7 57350.1 57414.7 57514.4 1303.7 1411.8 1445.4 1459.4 1547.0 28227.2 29467.7 29778.6 29853.7 30510.2 41633.8 41891.4 42178.8 42356.0 42400.6 215729.0 216602.0 216936.0 217013.0 217102.0 25353.7 27511.4 27525.0 27836.6 27973.3 39381.0 40949.6 40980.4 41246.8 41922.6 39447.6 39461.6 39769.0 40429.6 42817.8 38233.2 39009.4 39358.2 39495.2 39882.8 39913.4 40115.0 42688.4 43593.3 43700.0 33073.2 35294.5 35555.1 35748.3 35955.3 27880.3 28272.6 28311.6 28327.0 28348.4 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#2] jquery.html Cycles:180 Average:27691.05 Median:35491.73 stddev:78082.22 (220.0%) stddev-sans-first:78274.35 02:27:45 INFO - PROCESS | 31537 | Values: 385.9 388.0 388.4 397.9 405.6 14361.4 14979.3 17780.6 18334.5 18338.2 14478.6 16832.1 17011.0 17645.0 17680.3 5286.4 5700.3 5703.7 5707.3 5710.0 4053.3 5600.9 5676.1 5681.6 5901.3 6133.4 6153.2 6166.6 6167.1 6188.9 5984.7 6073.2 6134.6 6163.9 6177.7 5442.7 5442.7 5452.6 5461.6 5478.9 20168.4 20932.3 21599.4 21629.6 21806.6 2390.7 2391.2 2426.6 2533.2 2593.8 13364.2 13946.0 13995.2 14008.3 14205.6 1859.3 1906.7 1964.7 1976.6 2033.9 74562.0 76447.2 76468.7 77734.0 79247.6 9803.4 10154.0 10202.8 10298.4 10301.2 14188.2 14212.6 14309.1 14319.7 14341.0 7065.4 7275.8 7587.2 7626.1 7646.8 7942.2 8029.7 8093.2 8095.6 8102.1 6067.3 6284.3 6349.7 6353.7 6357.7 1714.3 1855.1 1870.8 1881.1 1945.3 898.5 952.6 976.5 1009.5 1018.0 17149.2 17451.8 17706.5 17859.5 18453.2 947.8 986.2 1009.5 1011.3 1022.2 9070.8 9592.7 9614.2 9678.0 9770.1 468784.0 472335.0 472836.0 473856.0 477914.0 93807.0 94292.0 94711.0 95688.0 97387.5 1063.1 1072.6 1082.1 1087.2 1105.2 14975.3 15084.9 15152.0 15221.7 15385.9 33638.3 35055.6 35471.6 35511.8 35735.0 37827.6 44542.3 52718.7 56719.4 57700.0 5050.2 6208.9 6652.8 7527.9 7842.0 8738.4 11821.8 12704.4 12766.2 12784.0 10857.1 11160.9 11392.4 11489.8 11531.5 10908.8 11044.8 11231.3 11258.0 11437.9 10701.8 10960.5 10992.4 11279.3 11322.2 7747.1 7765.2 7812.0 7983.4 8120.3 10467.7 11216.1 11347.7 11386.5 11422.7 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#3] mootools.html Cycles:180 Average:5598.71 Median:4696.15 stddev:3207.86 (68.3%) stddev-sans-first:3200.68 02:27:45 INFO - PROCESS | 31537 | Values: 1311.0 1450.6 1491.1 1607.5 1826.6 7700.6 8546.8 8747.3 8804.6 8809.3 8035.9 8143.1 8193.4 8201.4 8210.2 1991.7 2184.7 2255.5 2256.1 2286.3 2301.2 2311.3 2314.8 2319.6 2321.6 2231.7 2248.7 2251.2 2253.8 2260.5 1963.1 2143.8 2202.4 2209.0 2210.6 2128.4 2135.8 2139.2 2139.8 2188.7 8606.1 8626.1 8706.3 8716.6 8723.1 4897.9 5020.1 5022.1 5057.3 5059.6 3142.6 3174.6 3212.5 3240.5 3279.4 1032.3 1043.1 1046.4 1046.5 1067.5 11863.8 11969.6 11998.8 12024.7 12047.6 4153.5 4220.8 4333.0 4337.5 4354.2 9957.6 9982.3 10011.8 10018.0 10037.1 4585.4 4956.3 4973.7 4990.7 5004.5 4407.8 4490.8 4493.3 4502.7 4520.0 3772.4 3839.7 3897.7 4043.1 4069.0 1248.7 1269.1 1276.8 1277.9 1278.2 908.5 957.3 1002.6 1021.7 1025.3 6014.7 6038.8 6126.0 6130.5 6199.9 408.0 411.1 412.5 973.8 1000.4 3913.4 3967.3 3977.2 3996.0 3999.0 10375.6 10576.7 10853.6 10880.0 10917.0 10599.4 10604.6 10623.8 10753.9 10817.6 7962.5 7965.0 8023.6 8041.0 8134.9 5841.1 5942.9 5943.4 6033.1 6066.4 9417.2 9478.5 9530.9 9630.8 9680.8 9352.5 9729.0 9860.3 9929.2 9944.7 6851.2 7034.4 7063.1 7199.5 7306.9 8056.2 8278.2 8285.6 8289.1 8297.5 7257.3 7270.2 7394.6 7506.4 7525.0 7191.6 7218.5 7371.4 7379.7 7448.1 6832.6 6897.3 6907.2 6917.8 6933.6 4806.9 4956.4 4960.4 4987.2 5061.9 5093.7 5159.9 5160.4 5293.6 5323.1 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#4] prototype.html Cycles:180 Average:5053.11 Median:5795.38 stddev:1511.97 (26.1%) stddev-sans-first:1473.80 02:27:45 INFO - PROCESS | 31537 | Values: 315.5 317.5 323.4 325.7 331.7 5504.3 5668.6 5677.0 5698.0 5815.6 5666.9 5751.8 5767.4 5773.2 5808.3 4467.9 4470.2 4475.6 4477.1 4487.5 4418.8 4481.5 4481.5 4490.4 4491.6 4410.2 4424.5 4426.9 4434.7 4436.4 4365.5 4387.4 4417.8 4443.4 4444.4 3778.9 3869.9 3872.0 3886.7 3902.9 5542.8 5545.4 5547.0 5558.5 5565.2 5071.9 5107.3 5111.1 5118.0 5120.3 5797.0 6021.2 6040.4 6045.8 6054.5 4262.8 4272.9 4276.9 4276.9 4280.4 6296.7 6313.4 6315.0 6318.7 6321.1 4065.3 4237.9 4267.0 4278.5 4403.8 4279.1 4291.8 4295.6 4300.8 4334.6 4990.5 5007.6 5026.3 5027.7 5032.4 5766.7 5850.4 5954.2 6065.5 6091.3 1467.1 1489.6 1491.0 1493.6 1494.5 980.6 989.9 1002.6 1008.0 1010.9 5764.0 5796.0 5820.9 5822.8 5859.3 6146.0 6157.2 6175.9 6178.9 6211.7 5569.0 5766.4 5794.8 5820.9 5822.4 3238.4 3287.3 3302.8 3309.6 3328.6 6275.7 6302.5 6388.2 6425.8 6444.7 6296.9 6309.1 6315.5 6318.3 6334.4 6144.8 6409.5 6414.7 6415.8 6435.3 6128.6 6139.1 6173.7 6213.7 6219.4 6106.7 6130.9 6136.3 6142.5 6153.6 6176.8 6303.8 6378.9 6411.7 6416.0 4257.6 4267.2 4276.1 4285.5 4290.8 5829.7 5954.9 6176.6 6188.2 6202.1 6065.4 6073.5 6107.6 6115.9 6123.8 6055.3 6074.0 6100.4 6106.5 6113.3 5877.4 5967.5 6008.9 6009.8 6032.2 6079.6 6096.2 6097.2 6120.9 6133.6 5837.8 5887.9 5970.2 5986.7 5988.6 02:27:45 INFO - PROCESS | 31537 | 02:27:45 INFO - PROCESS | 31537 | [#5] yui.html Cycles:180 Average:14658.91 Median:24976.01 stddev:16874.91 (67.6%) stddev-sans-first:16890.29 02:27:45 INFO - PROCESS | 31537 | Values: 829.1 832.5 838.2 842.4 851.6 13140.1 13205.8 13355.7 13363.2 13405.3 12595.2 12703.4 12734.2 12756.8 13338.9 694.7 792.5 831.2 834.6 841.0 824.9 833.8 834.5 835.6 835.7 854.4 861.1 864.2 865.2 865.8 720.5 837.3 859.1 861.8 862.2 619.5 622.5 622.8 624.2 625.2 13821.9 13849.2 13857.7 13881.3 13889.6 12775.2 12961.4 13150.8 13211.7 13397.8 10997.3 11157.8 11485.1 11513.5 11621.4 3779.8 3798.4 3801.6 3851.5 3851.9 54656.5 54699.5 54791.7 54794.5 54799.7 10352.8 10534.8 10558.8 10778.2 10818.4 18798.7 18890.6 18930.4 19244.7 19268.0 8037.2 8044.9 8110.0 8117.4 8187.7 4759.1 4810.2 4869.7 4908.7 4934.6 3298.7 3413.8 3430.6 3440.6 3442.4 596.9 601.3 609.8 613.0 613.1 754.6 772.0 777.4 782.6 819.4 8960.0 8962.0 9030.6 9119.0 9160.8 596.6 707.8 746.7 747.7 760.2 4484.1 4540.5 4563.6 4565.4 4625.4 60900.7 61378.1 61395.0 61879.4 62323.7 53468.5 53644.2 54011.5 54444.2 54988.0 49229.3 50062.5 50163.5 50204.5 50697.7 8703.7 8724.0 8803.9 8868.7 8876.0 32169.5 32417.4 32618.2 32677.7 32768.5 40962.8 44289.3 44753.3 45044.3 45411.5 10844.9 11211.5 11212.5 12265.8 12336.9 13333.1 13612.3 13980.0 14016.5 14283.6 12192.8 12436.1 13007.2 13123.5 13550.4 13323.7 13413.5 13489.5 13534.8 14153.9 12409.6 12540.8 12588.7 12732.9 13454.2 11000.4 11185.7 11415.3 11419.5 11454.9 10832.1 11005.9 11274.6 11319.7 11362.4 02:27:45 INFO - PROCESS | 31537 | -------- Summary: end -------- 02:27:45 INFO - PROCESS | 31537 | 02:27:46 INFO - TEST-INFO | 31537: exit 0 02:27:46 INFO - TEST-OK | dromaeo_css | took 1112437ms 02:27:46 INFO - TEST-START | kraken 02:27:46 INFO - operating with platform_type : linux_ 02:27:46 INFO - Initialising browser for kraken test... 02:27:46 INFO - TEST-INFO | started process 31725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZExGs3/profile http://localhost:35799/getInfo.html) 02:27:50 INFO - PROCESS | 31725 | __metrics Screen width/height:1600/1200 02:27:50 INFO - PROCESS | 31725 | colorDepth:24 02:27:50 INFO - PROCESS | 31725 | Browser inner width/height: 1024/697 02:27:50 INFO - PROCESS | 31725 | __metrics 02:27:51 ERROR - PROCESS | 31725 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:27:52 INFO - TEST-INFO | 31725: exit 0 02:27:52 INFO - Browser initialized. 02:27:52 INFO - Running cycle 1/1 for kraken test... 02:27:52 INFO - TEST-INFO | started process 31806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZExGs3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:03 INFO - PROCESS | 31806 | RSS: Main: 153911296 02:28:03 INFO - PROCESS | 31806 | 02:28:06 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35799/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:07 INFO - PROCESS | 31806 | RSS: Main: 208007168 02:28:07 INFO - PROCESS | 31806 | 02:28:09 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35799/tests/kraken/driver.html?testName=audio-dft) 02:28:10 INFO - PROCESS | 31806 | RSS: Main: 193740800 02:28:10 INFO - PROCESS | 31806 | 02:28:13 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35799/tests/kraken/driver.html?testName=audio-fft) 02:28:14 INFO - PROCESS | 31806 | RSS: Main: 266608640 02:28:14 INFO - PROCESS | 31806 | 02:28:16 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35799/tests/kraken/driver.html?testName=audio-oscillator) 02:28:16 INFO - PROCESS | 31806 | RSS: Main: 173154304 02:28:16 INFO - PROCESS | 31806 | 02:28:19 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35799/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:19 INFO - PROCESS | 31806 | RSS: Main: 177598464 02:28:19 INFO - PROCESS | 31806 | 02:28:22 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35799/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:23 INFO - PROCESS | 31806 | RSS: Main: 213524480 02:28:23 INFO - PROCESS | 31806 | 02:28:26 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35799/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:27 INFO - PROCESS | 31806 | RSS: Main: 213475328 02:28:27 INFO - PROCESS | 31806 | 02:28:29 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35799/tests/kraken/driver.html?testName=json-parse-financial) 02:28:30 INFO - PROCESS | 31806 | RSS: Main: 213782528 02:28:30 INFO - PROCESS | 31806 | 02:28:32 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35799/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:32 INFO - PROCESS | 31806 | RSS: Main: 200531968 02:28:32 INFO - PROCESS | 31806 | 02:28:34 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:35 INFO - PROCESS | 31806 | RSS: Main: 202051584 02:28:35 INFO - PROCESS | 31806 | 02:28:37 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:37 INFO - PROCESS | 31806 | RSS: Main: 217161728 02:28:37 INFO - PROCESS | 31806 | 02:28:40 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:40 INFO - PROCESS | 31806 | RSS: Main: 222912512 02:28:40 INFO - PROCESS | 31806 | 02:28:43 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:44 INFO - PROCESS | 31806 | RSS: Main: 219086848 02:28:44 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | Cycle 1(1): loaded http://localhost:35799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35799/tests/kraken/driver.html?testName=ai-astar) 02:28:46 INFO - PROCESS | 31806 | RSS: Main: 282337280 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | __start_tp_report 02:28:46 INFO - PROCESS | 31806 | _x_x_mozilla_page_load 02:28:46 INFO - PROCESS | 31806 | _x_x_mozilla_page_load_details 02:28:46 INFO - PROCESS | 31806 | |i|pagename|runs| 02:28:46 INFO - PROCESS | 31806 | |0;ai-astar;108;111;105;110;112;110;100;111;108;111 02:28:46 INFO - PROCESS | 31806 | |1;audio-beat-detection;152;129;152;191;129;151;160;129;192;136 02:28:46 INFO - PROCESS | 31806 | |2;audio-dft;162;160;162;161;160;160;161;161;160;161 02:28:46 INFO - PROCESS | 31806 | |3;audio-fft;74;73;107;109;74;75;72;118;102;73 02:28:46 INFO - PROCESS | 31806 | |4;audio-oscillator;92;92;154;93;92;93;150;92;92;153 02:28:46 INFO - PROCESS | 31806 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;116;117 02:28:46 INFO - PROCESS | 31806 | |6;imaging-darkroom;146;146;147;145;146;146;146;147;145;147 02:28:46 INFO - PROCESS | 31806 | |7;imaging-desaturate;95;94;95;94;95;95;94;95;95;95 02:28:46 INFO - PROCESS | 31806 | |8;json-parse-financial;58;58;56;56;58;56;57;75;56;55 02:28:46 INFO - PROCESS | 31806 | |9;json-stringify-tinderbox;61;62;62;61;62;63;64;61;63;65 02:28:46 INFO - PROCESS | 31806 | |10;stanford-crypto-aes;76;76;76;76;78;76;86;78;77;77 02:28:46 INFO - PROCESS | 31806 | |11;stanford-crypto-ccm;132;126;129;124;123;132;126;125;158;127 02:28:46 INFO - PROCESS | 31806 | |12;stanford-crypto-pbkdf2;169;169;171;171;171;176;172;169;172;172 02:28:46 INFO - PROCESS | 31806 | |13;stanford-crypto-sha256-iterative;69;70;68;69;69;68;71;71;70;68 02:28:46 INFO - PROCESS | 31806 | __end_tp_report 02:28:46 INFO - PROCESS | 31806 | __start_cc_report 02:28:46 INFO - PROCESS | 31806 | _x_x_mozilla_cycle_collect,1630 02:28:46 INFO - PROCESS | 31806 | __end_cc_report 02:28:46 INFO - PROCESS | 31806 | __startTimestamp1460971726256__endTimestamp 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | ------- Summary: start ------- 02:28:46 INFO - PROCESS | 31806 | Number of tests: 14 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.66 (3.3%) stddev-sans-first:3.87 02:28:46 INFO - PROCESS | 31806 | Values: 108.0 111.0 105.0 110.0 112.0 110.0 100.0 111.0 108.0 111.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:152.00 stddev:23.64 (15.6%) stddev-sans-first:25.07 02:28:46 INFO - PROCESS | 31806 | Values: 152.0 129.0 152.0 191.0 129.0 151.0 160.0 129.0 192.0 136.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:28:46 INFO - PROCESS | 31806 | Values: 162.0 160.0 162.0 161.0 160.0 160.0 161.0 161.0 160.0 161.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#3] audio-fft Cycles:10 Average:87.70 Median:73.00 stddev:18.75 (25.7%) stddev-sans-first:19.22 02:28:46 INFO - PROCESS | 31806 | Values: 74.0 73.0 107.0 109.0 74.0 75.0 72.0 118.0 102.0 73.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.00 stddev:29.03 (31.5%) stddev-sans-first:30.02 02:28:46 INFO - PROCESS | 31806 | Values: 92.0 92.0 154.0 93.0 92.0 93.0 150.0 92.0 92.0 153.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:28:46 INFO - PROCESS | 31806 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:28:46 INFO - PROCESS | 31806 | Values: 146.0 146.0 147.0 145.0 146.0 146.0 146.0 147.0 145.0 147.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:28:46 INFO - PROCESS | 31806 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.50 stddev:5.89 (10.2%) stddev-sans-first:6.25 02:28:46 INFO - PROCESS | 31806 | Values: 58.0 58.0 56.0 56.0 58.0 56.0 57.0 75.0 56.0 55.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.33 02:28:46 INFO - PROCESS | 31806 | Values: 61.0 62.0 62.0 61.0 62.0 63.0 64.0 61.0 63.0 65.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.06 (4.0%) stddev-sans-first:3.19 02:28:46 INFO - PROCESS | 31806 | Values: 76.0 76.0 76.0 76.0 78.0 76.0 86.0 78.0 77.0 77.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:128.00 stddev:10.24 (8.0%) stddev-sans-first:10.84 02:28:46 INFO - PROCESS | 31806 | Values: 132.0 126.0 129.0 124.0 123.0 132.0 126.0 125.0 158.0 127.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:2.10 (1.2%) stddev-sans-first:2.07 02:28:46 INFO - PROCESS | 31806 | Values: 169.0 169.0 171.0 171.0 171.0 176.0 172.0 169.0 172.0 172.0 02:28:46 INFO - PROCESS | 31806 | 02:28:46 INFO - PROCESS | 31806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 02:28:46 INFO - PROCESS | 31806 | Values: 69.0 70.0 68.0 69.0 69.0 68.0 71.0 71.0 70.0 68.0 02:28:46 INFO - PROCESS | 31806 | -------- Summary: end -------- 02:28:46 INFO - PROCESS | 31806 | 02:28:47 INFO - TEST-INFO | 31806: exit 0 02:28:47 INFO - TEST-OK | kraken | took 61163ms 02:28:47 INFO - SUITE-END | took 1173s 02:28:47 INFO - Completed test suite (00:19:33) 02:28:47 INFO - javascript benchmark 02:28:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.5505651680505, 3127.0931429885336, 3154.7949383290083, 3161.7944833585802, 3196.392685389775, 5227.843164705056, 5236.083685355066, 5268.157094864818, 5293.523582877545, 5342.145256758915, 5301.363836339645, 5323.9467605323935, 5327.520523152915, 5328.653637513559, 5391.757370918308, 4780.78486468108, 4828.710277383359, 4893.29047288143, 4921.655484116113, 4972.726500042496, 4884.926726099094, 4908.705477671333, 4911.23641919703, 4916.803327866899, 4919.434265059528, 4716.363290955728, 4753.976230118862, 4774.570288674018, 4779.426468823729, 4895.7062576245535, 4762.952370476286, 4772.880677983078, 4780.498047704976, 4782.665213435061, 4811.278308253755, 4726.125666751627, 4764.8332308369045, 4779.784909679072, 4793.599234777769, 4796.9760151199025, 5119.180931051014, 5142.7685754140775, 5162.380514338266, 5216.426193118754, 5225.2162175673575, 5613.410591887875, 5641.323041235037, 5644.181593668936, 5650.3219613646215, 5655.462731040545, 5469.644473109275, 5590.413006634326, 5639.295088113986, 5672.4611161939965, 5689.0, 5259.76331065103, 5259.86850328741, 5262.92105618416, 5265.710385928773, 5325.840224793263, 5716.828495145069, 5743.885122297531, 5753.942460575425, 5765.019946609086, 5773.6824474654295, 5371.516563509303, 5454.372747134051, 5497.147942068986, 5522.061249587579, 5538.723063846872, 5566.332040155207, 5571.888562228733, 5583.0, 5586.13414920688, 5597.692126933058, 5551.333839939233, 5552.91670624941, 5554.50009499147, 5555.3333599967455, 5570.526505247019, 5468.671879687152, 5528.253685752372, 5596.804111856066, 5630.97184514083, 5631.521320687705, 4272.807723652443, 4273.829046838154, 4276.294411422143, 4277.0, 4320.330348795942, 3814.694824414096, 3865.729398942047, 3868.6518213360932, 3892.0464486200494, 3893.902652433655, 5218.269442278084, 5301.443348448434, 5342.652727572696, 5370.704611246419, 5375.3012108425655, 5542.8337149885565, 5543.057680194376, 5544.140658197985, 5551.861203469864, 5552.6668399895325, 5162.1224391853475, 5207.297014903015, 5229.555487783505, 5234.450382709761, 5269.077911365495, 4838.080764654705, 4902.926456103161, 4909.459959404463, 4928.989557140778, 4929.211326187793, 5756.65460072397, 5778.335491418541, 5782.59521833476, 5788.507976821933, 5806.158107074535, 5490.5882058844945, 5623.268975033301, 5635.971820140873, 5650.886982260249, 5695.772169113189, 5727.770889164553, 5754.597178197486, 5781.624194427349, 5797.652140871562, 5843.094320380348, 5486.807961721321, 5490.670559766267, 5503.3395992481155, 5504.422035686195, 5505.0, 5467.781288748405, 5528.861778455571, 5576.609637325349, 5584.832455026356, 5592.3009623797025, 5423.213634022965, 5450.700211488248, 5458.099413596712, 5467.972660136674, 5511.090670039399, 5402.297701298806, 5407.540359069366, 5433.5924805640525, 5434.83695489136, 5497.312835895513, 5319.095753721954, 5344.038073146871, 5374.355077390738, 5423.430539793423, 5488.753006114654, 5474.507294343369, 5482.23248745184, 5484.149956756709, 5489.5608351331, 5528.032594295902, 5359.892802143857, 5371.731413429235, 5376.946230537645, 5380.488853558905, 5420.186971954238], "value": 5178.005200114648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.8383928259009, 646.9482441404688, 650.1093501902393, 661.4774328280662, 662.5461558832201, 29230.0, 30016.699833001665, 37104.257914841684, 37361.813190934074, 37632.0, 39952.200955980865, 40751.38872916901, 40861.59138408615, 41030.589694103124, 41058.99999999993, 8386.790330241747, 8576.313894888424, 8580.356473264499, 8582.613782379807, 8585.527795971218, 7856.7642970710685, 10085.0, 10383.376997380143, 10391.064804167623, 10399.272050956437, 10023.298369114165, 10106.039926207035, 10111.342762720436, 10111.595536178544, 10116.848247276297, 7895.802604934923, 9980.600775968953, 10108.646197383094, 10108.64619738313, 10117.291789574732, 9952.452615106165, 10120.544575494047, 10120.898791012069, 10123.0, 10124.797504049951, 40021.59978400208, 40604.39093413601, 40729.59270407288, 40843.18313633711, 40976.38535421971, 3287.7862938908893, 3424.434968230239, 3545.6986156176754, 3860.749051311656, 4026.6376026157495, 31366.0, 31485.212869678442, 31874.0, 31899.202519936956, 32346.6765332346, 4272.5086615039045, 4276.080642661843, 4311.612443363343, 4364.650827933758, 4415.028693687384, 299228.0, 299910.00899910054, 303922.0, 304795.0, 304916.0, 35427.11432214215, 36240.81879590585, 57851.4214857846, 58115.0, 58402.0, 34326.14184645404, 34355.82822085873, 34556.88987991093, 34558.136046598534, 34595.65404345975, 15054.623634409008, 15192.240387980777, 15263.313150908014, 15286.694266114615, 15288.847111528965, 12214.75570488603, 12224.26654400721, 12233.143679942497, 12276.202046866925, 12276.693082673004, 8552.230299272971, 8559.315254779603, 8594.140585941355, 8651.783705407415, 8660.8700869487, 3278.0821370016433, 3317.374486501645, 3331.4170020246843, 3346.899593012165, 3359.177001634615, 912.2200518556671, 1107.6566264458045, 1122.7810576937582, 1180.8582970043649, 1226.3132645718426, 28822.567661485093, 29646.851765741034, 29652.258693532833, 30112.0, 30227.697723022487, 1108.8613923259593, 1129.1192869561755, 1144.4849817581955, 1153.8153895376868, 1205.9095567832449, 15784.842151578338, 16423.589410264838, 16610.50168494947, 17130.743038854427, 17179.57051073708, 444278.0, 446032.0, 449852.0, 449928.0, 450750.0, 56195.43804561902, 57010.71494642583, 57350.13974790381, 57414.7129264351, 57514.424855750905, 1303.7066660001612, 1411.7600007998665, 1445.4218312675014, 1459.4162335065846, 1546.9789938640442, 28227.15318540447, 29467.705322946495, 29778.553321699757, 29853.701462985962, 30510.237244069074, 41633.79183104065, 41891.37162942619, 42178.789106054275, 42356.0, 42400.57599423966, 215729.0, 216602.0, 216936.0, 217013.0, 217102.0, 25353.74646253514, 27511.449771004867, 27525.0, 27836.582451262842, 27973.300667483476, 39381.0, 40949.59050409458, 40980.3852942212, 41246.793766030976, 41922.58077419187, 39447.605523944396, 39461.60538394694, 39769.0, 40429.595704042586, 42817.78591107025, 38233.23533529369, 39009.41485877771, 39358.21283574255, 39495.210095797345, 39882.80058599688, 39913.401298981116, 40115.0, 42688.35967460428, 43593.346099807895, 43700.0, 33073.173170670925, 35294.47058294076, 35555.11112222112, 35748.28503429865, 35955.280894382486, 27880.302992425353, 28272.575911360935, 28311.575326369708, 28327.0, 28348.433031338845], "value": 18101.327644127698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8732501096797, 387.96120387961207, 388.3882884456979, 397.92041591681664, 405.55794184339067, 14361.35373908174, 14979.325930333134, 17780.555486112837, 18334.541636459096, 18338.174782134804, 14478.565643030699, 16832.074235917018, 17011.0, 17645.00034994051, 17680.292788288454, 5286.365636123661, 5700.258966334371, 5703.714814259291, 5707.315122185323, 5710.0, 4053.3312003519386, 5600.887982240352, 5676.148577713335, 5681.630694004897, 5901.321348044966, 6133.44798968095, 6153.200083989098, 6166.568340216187, 6167.136600875881, 6188.876222475547, 5984.670843103606, 6073.240844894388, 6134.631922084667, 6163.87672246557, 6177.733564619287, 5442.700651464168, 5442.727863606804, 5452.59105567084, 5461.644993075477, 5478.863028424282, 20168.394948151577, 20932.267370641955, 21599.35201943944, 21629.567408651896, 21806.563868722536, 2390.6533552634946, 2391.2228525729033, 2426.551088048717, 2533.2147034419204, 2593.7679602188996, 13364.198148111145, 13946.0, 13995.160290382508, 14008.299585020708, 14205.644858878508, 1859.33064096925, 1906.713992901062, 1964.6856502959602, 1976.5651556657513, 2033.9389818305326, 74562.0, 76447.23552764513, 76468.7354701308, 77734.0, 79247.60376198082, 9803.411795292306, 10154.0, 10202.846957295647, 10298.3820970742, 10301.175905927508, 14188.219647919257, 14212.644683882985, 14309.069910455786, 14319.713605727828, 14341.0, 7065.43476521877, 7275.818104547428, 7587.165411804697, 7626.122995855437, 7646.808829779189, 7942.245486678757, 8029.678812847421, 8093.231143041402, 8095.554744488992, 8102.149274326111, 6067.332593414721, 6284.340144284875, 6349.6507692077375, 6353.682315884187, 6357.7139028742895, 1714.3451369941083, 1855.1448551448552, 1870.7568016157813, 1881.0500697147852, 1945.3094151575988, 898.4833720610675, 952.5903861339552, 976.5215044628081, 1009.4700282351824, 1017.9694609161737, 17149.228284727218, 17451.82548174502, 17706.46880593584, 17859.46421607354, 18453.1696073677, 947.8246524392871, 986.2405947420447, 1009.4851625670814, 1011.3476807459294, 1022.2282176956351, 9070.818583628423, 9592.712218633313, 9614.173307071635, 9678.0, 9770.12068913787, 468784.0, 472335.0, 472836.0, 473856.0, 477914.0, 93807.0, 94292.0, 94711.0, 95688.0, 97387.51306243423, 1063.1335461598771, 1072.6084978982615, 1082.0640146273417, 1087.2226358153957, 1105.2042529378673, 14975.251237438302, 15084.924575377492, 15152.0, 15221.695566088394, 15385.922985390915, 33638.32723345568, 35055.64944350524, 35471.64528354786, 35511.82244088763, 35735.0, 37827.62172378241, 44542.3318650227, 52718.73640631772, 56719.432805671415, 57700.0, 5050.191969284897, 6208.906866397098, 6652.800415987528, 7527.887081693889, 7841.960790196013, 8738.388312818295, 11821.822672659744, 12704.428300726304, 12766.234025958473, 12784.0, 10857.13142948578, 11160.944195278971, 11392.430378480876, 11489.827652585385, 11531.481083351102, 10908.781824363627, 11044.779104418027, 11231.26996745209, 11257.986781189733, 11437.885621143681, 10701.785964280514, 10960.451977401257, 10992.395418252074, 11279.32324060559, 11322.207445478738, 7747.147813740371, 7765.1846556110795, 7812.0, 7983.401244906771, 8120.309773669304, 10467.738306542398, 11216.102711782874, 11347.659570212907, 11386.544538218379, 11422.714432139262], "value": 8906.005054952187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.0363882546321, 1450.6373406648338, 1491.0829839648616, 1607.5177446765967, 1826.58901747107, 7700.576468294242, 8546.786330341745, 8747.300215982723, 8804.603792829323, 8809.295256379482, 8035.879461808077, 8143.144969778177, 8193.426460147792, 8201.425900186974, 8210.178982101786, 1991.7211590377358, 2184.715986921698, 2255.4699645583273, 2256.0750092462094, 2286.2569664858906, 2301.1945818963395, 2311.318161142467, 2314.7916687498123, 2319.5940710375703, 2321.6401457774073, 2231.6540936154843, 2248.7301523817164, 2251.167068184766, 2253.808426283768, 2260.5026894083276, 1963.1460314763053, 2143.7641859395453, 2202.383332666856, 2209.028027667821, 2210.5910406574835, 2128.4040468668795, 2135.839812014105, 2139.1657253671083, 2139.796719311663, 2188.6826410170597, 8606.139386061406, 8626.051134375213, 8706.259967902735, 8716.607752651145, 8723.084076171974, 4897.902041959176, 5020.1214787412055, 5022.1211288024815, 5057.291979122926, 5059.569936555397, 3142.6228852537615, 3174.6349169845535, 3212.4860022396306, 3240.4815229563155, 3279.376918385523, 1032.3238278927315, 1043.1341986151476, 1046.3878631000873, 1046.502911117221, 1067.4769363012147, 11863.762724745544, 11969.581064662694, 11998.820017699654, 12024.69938251542, 12047.638570842888, 4153.460050193456, 4220.831166753295, 4333.0, 4337.503561271356, 4354.216241076637, 9957.601695932082, 9982.251331150193, 10011.79976400468, 10018.0, 10037.146842518321, 4585.426821647294, 4956.256561515729, 4973.676711013845, 4990.725510096907, 5004.524570165829, 4407.757573333433, 4490.797914093873, 4493.348464472633, 4502.662300327489, 4519.977400112978, 3772.3775577030033, 3839.6928245740273, 3897.7466464679705, 4043.130726893732, 4069.04377471294, 1248.6836917518056, 1269.0672355818467, 1276.8403949506312, 1277.9297138657464, 1278.239447528719, 908.5457271364318, 957.2533423929347, 1002.6139936124645, 1021.6832781837505, 1025.3027941000191, 6014.72933717975, 6038.758449662052, 6125.9693701531205, 6130.509559235251, 6199.907001394983, 407.96532294754684, 411.1140492239229, 412.5152945289333, 973.7808992976524, 1000.3597697473623, 3913.4325522799604, 3967.26605577969, 3977.2244412339896, 3995.9800200998807, 3998.9800051000143, 10375.63685271027, 10576.735581610521, 10853.565857365775, 10880.020798128206, 10917.017468427879, 10599.417032063157, 10604.628837990633, 10623.84064239037, 10753.892461075446, 10817.621383251548, 7962.522248665098, 7964.960175199087, 8023.598820058974, 8040.959795201104, 8134.918650813416, 5841.065429531254, 5942.851428714317, 5943.435373639497, 6033.12519684652, 6066.393360663898, 9417.199538039069, 9478.478683672463, 9530.85703714431, 9630.759231019281, 9680.75798105053, 9352.485613291334, 9728.951355243178, 9860.260480464138, 9929.205663546754, 9944.701658950244, 6851.246362900177, 7034.437245020284, 7063.081799366049, 7199.532030418006, 7306.853862922818, 8056.194380562131, 8278.213569710868, 8285.627146778288, 8289.129641387568, 8297.460665056751, 7257.346838784323, 7270.163931147986, 7394.593297368697, 7506.437017223621, 7525.0, 7191.604461754445, 7218.494705370574, 7371.4102871769055, 7379.704811807467, 7448.068991376078, 6832.59004459734, 6897.3447522485285, 6907.205671347659, 6917.827054323481, 6933.618650974245, 4806.8798280043275, 4956.3804524434445, 4960.379952505937, 4987.202047672355, 5061.898762024813, 5093.71984540839, 5159.948400515947, 5160.406553246275, 5293.576513878804, 5323.121684922099], "value": 4440.648318697804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4763093265179, 317.52529967698297, 323.3855674218982, 325.6694455128045, 331.7478716175706, 5504.256925315081, 5668.57485688574, 5677.0, 5698.005698005702, 5815.592908496402, 5666.858328541778, 5751.769929202837, 5767.394423585526, 5773.249477567921, 5808.273965754281, 4467.9329810052795, 4470.195364834329, 4475.552444755531, 4477.082198149372, 4487.461504619434, 4418.826153686727, 4481.484629267643, 4481.507034226249, 4490.41624588803, 4491.550844915499, 4410.16206920684, 4424.513303536608, 4426.86719398417, 4434.68957172998, 4436.44544431946, 4365.5416181300825, 4387.3857659927635, 4417.845375411877, 4443.400140980974, 4444.377787109791, 3778.9433158502643, 3869.903252418712, 3871.9612803871883, 3886.650201481852, 3902.941455878164, 5542.806001789918, 5545.423202034665, 5547.0, 5558.527525160366, 5565.193047008162, 5071.923921141186, 5107.3360463139925, 5111.08000559899, 5117.974410127926, 5120.308758317617, 5797.0, 6021.163545118737, 6040.365761595057, 6045.825941380766, 6054.545909056838, 4262.7655478948645, 4272.9145417091795, 4276.87169384919, 4276.914461710749, 4280.357946308079, 6296.685165741695, 6313.431791138773, 6314.989601663758, 6318.652474113922, 6321.083442900754, 4065.288574499451, 4237.851675191354, 4266.957330426718, 4278.529361770203, 4403.84586539476, 4279.122779830127, 4291.849785257501, 4295.613394794484, 4300.7634580097765, 4334.5882141196535, 4990.525900039491, 5007.574356179693, 5026.29631851541, 5027.748612569357, 5032.3961124665275, 5766.654000759968, 5850.444207800252, 5954.166416701665, 6065.484433823086, 6091.299500557404, 1467.0977348930544, 1489.6127006978263, 1490.9627259318604, 1493.5668656089829, 1494.5292232946588, 980.5734505490135, 989.9010098990043, 1002.6290272599039, 1007.9596816127273, 1010.8938561451089, 5764.0, 5795.971020144957, 5820.854478637983, 5822.767089316465, 5859.267591551056, 6145.96927015371, 6157.168782214344, 6175.876482470326, 6178.876422471525, 6211.689415529206, 5569.0, 5766.365699773021, 5794.797182098607, 5820.912686309709, 5822.359540450547, 3238.3847069057274, 3287.260366417585, 3302.78531895426, 3309.635940046593, 3328.56728625282, 6275.717592708339, 6302.4958003359625, 6388.201474815648, 6425.807225783234, 6444.742210311629, 6296.905546416808, 6309.14826498426, 6315.526335524854, 6318.304986451487, 6334.429901308904, 6144.78493252734, 6409.487241020707, 6414.743410263537, 6415.824167037346, 6435.2599451063725, 6128.63228206309, 6139.145297436535, 6173.722182501709, 6213.720382582705, 6219.414049417551, 6106.664133472702, 6130.854201029604, 6136.2636483622255, 6142.508599311955, 6153.5692501526255, 6176.845578860564, 6303.810885673437, 6378.936210637834, 6411.743530258737, 6416.0, 4257.5529569396, 4267.231898258343, 4276.123394704016, 4285.528591854956, 4290.849820256276, 5829.697269578577, 5954.851128721643, 6176.567640265138, 6188.164597779242, 6202.069689546604, 6065.3934606539, 6073.514118870568, 6107.633541987495, 6115.908261376172, 6123.785667501616, 6055.333913269449, 6074.0, 6100.420460056288, 6106.511479081574, 6113.2969708482315, 5877.441643043904, 5967.492763115184, 6008.8798224036145, 6009.789657361971, 6032.1856549365275, 6079.635221886701, 6096.177016102769, 6097.207363042776, 6120.938790612036, 6133.60131591463, 5837.824865254049, 5887.852803679943, 5970.194023806731, 5986.700664966821, 5988.610740301867], "value": 4557.112425319567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.1206251211618, 832.5421018439856, 838.1702114906241, 842.397685654757, 851.64656667483, 13140.14589051711, 13205.801912971288, 13355.732885342288, 13363.198208107508, 13405.262710550916, 12595.181313214634, 12703.428345724442, 12734.172278801894, 12756.808647870266, 13338.866611333884, 694.6526736631685, 792.5205250823255, 831.193742070191, 834.6452757578036, 841.032812265896, 824.8968878890139, 833.7998880268722, 834.5159807311744, 835.5696816139692, 835.678263868412, 854.372036553133, 861.0915484164204, 864.2135656552507, 865.1867244789877, 865.8138500222451, 720.531654424623, 837.3426859914938, 859.1065292096213, 861.7759382560516, 862.1637012098255, 619.5013014523307, 622.4584611388121, 622.8007037747923, 624.2010226909563, 625.1903784598956, 13821.930890345584, 13849.238291893942, 13857.722845543134, 13881.305934703225, 13889.583312500641, 12775.23348599087, 12961.41673624689, 13150.802737958938, 13211.669708257274, 13397.799033014513, 10997.285176463503, 11157.776844463146, 11485.138614603939, 11513.481893314822, 11621.418929053514, 3779.7543159694533, 3798.4302354647025, 3801.581825999138, 3851.5185601799776, 3851.9422208666892, 54656.45343546553, 54699.45300547023, 54791.72604136993, 54794.452055479334, 54799.72600136974, 10352.792944141225, 10534.789304214026, 10558.788824223473, 10778.19163562736, 10818.404987725751, 18798.718019229724, 18890.622187556448, 18930.43208703741, 19244.71132933007, 19268.0, 8037.196280371916, 8044.879326810103, 8110.026796784306, 8117.350611951029, 8187.7134300300395, 4759.143354196209, 4810.230363141881, 4869.683470574401, 4908.730019848943, 4934.605231581465, 3298.719608833276, 3413.795172289621, 3430.622631510532, 3440.569928758905, 3442.4147894857933, 596.9194158788508, 601.3415310235285, 609.7713357490941, 612.9908051379233, 613.089562000429, 754.607604045904, 771.9691212351443, 777.3547955197173, 782.6008735544913, 819.3772732723054, 8960.0, 8961.955190224138, 9030.593623286968, 9118.95440522793, 9160.770980725536, 596.6241268001131, 707.7876637008877, 746.6677328588835, 747.704656660616, 760.1551983529918, 4484.0583477469445, 4540.477845047862, 4563.634909207255, 4565.429321334833, 4625.352450656911, 60900.69549652223, 61378.079328810105, 61395.0, 61879.38120618826, 62323.688381557804, 53468.46531534635, 53644.19533706998, 54011.45988540064, 54444.183337249975, 54988.0, 49229.261561076615, 50062.49937500651, 50163.49836501661, 50204.49795502071, 50697.74651126721, 8703.695370661997, 8724.0, 8803.867941981003, 8868.733937981871, 8875.955620221857, 32169.517457238628, 32417.35165296728, 32618.184545386554, 32677.673223267462, 32768.50847237341, 40962.79518602388, 44289.33565996577, 44753.32870006887, 45044.32433513566, 45411.545884540734, 10844.891551084389, 11211.495482703462, 11212.49543770516, 12265.754684906431, 12336.876631233932, 13333.133346332457, 13612.319384030958, 13979.99177472672, 14016.509422170175, 14283.571492855232, 12192.756144876876, 12436.067294953096, 13007.219566826021, 13123.54067607629, 13550.390232439368, 13323.66690832737, 13413.530526431528, 13489.460421583419, 13534.79697804514, 14153.938454616151, 12409.565665201675, 12540.811887821508, 12588.748225035632, 12732.87267127317, 13454.192748435125, 11000.449977501254, 11185.720356990814, 11415.258008229439, 11419.543218271509, 11454.94272528632, 10832.133429325793, 11005.889941100806, 11274.60538881168, 11319.717007074889, 11362.375069371265], "value": 6733.213875210565, "unit": "score"}], "name": "dromaeo_css", "value": 6960.798178645015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 105.0, 110.0, 112.0, 110.0, 100.0, 111.0, 108.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 152.0, 191.0, 129.0, 151.0, 160.0, 129.0, 192.0, 136.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 107.0, 109.0, 74.0, 75.0, 72.0, 118.0, 102.0, 73.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 93.0, 92.0, 93.0, 150.0, 92.0, 92.0, 153.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 56.0, 58.0, 56.0, 57.0, 75.0, 56.0, 55.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 63.0, 64.0, 61.0, 63.0, 65.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 78.0, 76.0, 86.0, 78.0, 77.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 129.0, 124.0, 123.0, 132.0, 126.0, 125.0, 158.0, 127.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 171.0, 171.0, 171.0, 176.0, 172.0, 169.0, 172.0, 172.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 71.0, 71.0, 70.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1546.0000000000002, "alertThreshold": 2.0}]} 02:28:47 INFO - Return code: 0 02:28:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:47 ERROR - # TBPL SUCCESS # 02:28:47 INFO - Running post-action listener: _resource_record_post_action 02:28:47 INFO - Running post-run listener: _resource_record_post_run 02:28:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 533569536; Read time: 372; Write time: 583028 02:28:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244191232; Read time: 196; Write time: 379744 02:28:48 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289378304; Read time: 176; Write time: 203284 02:28:48 INFO - Running post-run listener: _upload_blobber_files 02:28:48 INFO - Blob upload gear active. 02:28:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:49 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:49 INFO - (blobuploader) - INFO - Done attempting. 02:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:50 INFO - (blobuploader) - INFO - Done attempting. 02:28:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:50 INFO - Return code: 0 02:28:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7e079a0b8c5372077b913bc1b0fd8187136374bf937d0a1f64d7161e7c7b16575358e605d2ffcda89d8d9ae193421573fbe4c5d044344a67c7f721a7e78df2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8068bc19c8c85ef324fa193fcbe0f8fa8015e9390bcf5a63fb4845bd487b3a2479bc1821cd2112aa60c6ff08f5ad7a2c8503cc4f296a65bc38ca7de21538a7f"} 02:28:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:50 INFO - Contents: 02:28:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7e079a0b8c5372077b913bc1b0fd8187136374bf937d0a1f64d7161e7c7b16575358e605d2ffcda89d8d9ae193421573fbe4c5d044344a67c7f721a7e78df2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8068bc19c8c85ef324fa193fcbe0f8fa8015e9390bcf5a63fb4845bd487b3a2479bc1821cd2112aa60c6ff08f5ad7a2c8503cc4f296a65bc38ca7de21538a7f"} 02:28:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:50 INFO - Copying logs to upload dir... 02:28:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.445465 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-18 02:28:50.676268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 02:28:50.679582) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7e079a0b8c5372077b913bc1b0fd8187136374bf937d0a1f64d7161e7c7b16575358e605d2ffcda89d8d9ae193421573fbe4c5d044344a67c7f721a7e78df2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8068bc19c8c85ef324fa193fcbe0f8fa8015e9390bcf5a63fb4845bd487b3a2479bc1821cd2112aa60c6ff08f5ad7a2c8503cc4f296a65bc38ca7de21538a7f"} build_url:https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7e079a0b8c5372077b913bc1b0fd8187136374bf937d0a1f64d7161e7c7b16575358e605d2ffcda89d8d9ae193421573fbe4c5d044344a67c7f721a7e78df2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8068bc19c8c85ef324fa193fcbe0f8fa8015e9390bcf5a63fb4845bd487b3a2479bc1821cd2112aa60c6ff08f5ad7a2c8503cc4f296a65bc38ca7de21538a7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 02:28:50.704880) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:28:50.705253) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460969973.901386-220720968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:28:50.790108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 02:28:50.790442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 02:28:50.790732) ========= ========= Total master_lag: 0.94 =========