builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1462880486.37 results: success (0) buildid: 20160510030710 builduid: 2365e4bf703b425484e5d911e00d7883 revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.367305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.367821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.368145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.381048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.381357) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 04:41:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-10 04:41:26 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.542441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.542866) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014186 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.594430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:26.595115) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 04:41:26,655 truncating revision to first 12 chars 2016-05-10 04:41:26,655 Setting DEBUG logging. 2016-05-10 04:41:26,655 attempt 1/10 2016-05-10 04:41:26,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1579b9e2e50f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 04:41:27,294 unpacking tar archive at: mozilla-central-1579b9e2e50f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:27.523708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:27.524033) ========= script_repo_revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:27.524421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:27.524699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:27.533797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 04:41:27.534068) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:27 INFO - MultiFileLogger online at 20160510 04:41:27 in /builds/slave/test 04:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:27 INFO - {'append_to_log': False, 04:41:27 INFO - 'base_work_dir': '/builds/slave/test', 04:41:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:27 INFO - 'branch': 'Firefox-Non-PGO', 04:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:27 INFO - 'config_files': ('talos/linux_config.py',), 04:41:27 INFO - 'default_actions': ('clobber', 04:41:27 INFO - 'read-buildbot-config', 04:41:27 INFO - 'download-and-extract', 04:41:27 INFO - 'populate-webroot', 04:41:27 INFO - 'create-virtualenv', 04:41:27 INFO - 'install', 04:41:27 INFO - 'run-tests'), 04:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:27 INFO - 'download_minidump_stackwalk': True, 04:41:27 INFO - 'download_symbols': 'ondemand', 04:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:27 INFO - 'installer_path': 'installer.exe', 04:41:27 INFO - 'log_level': 'info', 04:41:27 INFO - 'log_name': 'talos', 04:41:27 INFO - 'log_to_console': True, 04:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:27 INFO - 'opt_config_files': (), 04:41:27 INFO - 'pip_index': False, 04:41:27 INFO - 'sps_profile': False, 04:41:27 INFO - 'sps_profile_interval': 0, 04:41:27 INFO - 'suite': 'dromaeojs', 04:41:27 INFO - 'system_bits': '32', 04:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:27 INFO - 'title': 'talos-linux64-ix-024', 04:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:27 INFO - 'use_talos_json': True, 04:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:27 INFO - 'work_dir': 'build'} 04:41:27 INFO - ##### 04:41:27 INFO - ##### Running clobber step. 04:41:27 INFO - ##### 04:41:27 INFO - Running pre-action listener: _resource_record_pre_action 04:41:27 INFO - Running main action method: clobber 04:41:27 INFO - rmtree: /builds/slave/test/build 04:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:28 INFO - Running post-action listener: _resource_record_post_action 04:41:28 INFO - ##### 04:41:28 INFO - ##### Finished clobber step (success) 04:41:28 INFO - ##### 04:41:28 INFO - ##### 04:41:28 INFO - ##### Running read-buildbot-config step. 04:41:28 INFO - ##### 04:41:28 INFO - Running pre-action listener: _resource_record_pre_action 04:41:28 INFO - Running main action method: read_buildbot_config 04:41:28 INFO - Using buildbot properties: 04:41:28 INFO - { 04:41:28 INFO - "project": "", 04:41:28 INFO - "product": "firefox", 04:41:28 INFO - "script_repo_revision": "production", 04:41:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:41:28 INFO - "repository": "", 04:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:41:28 INFO - "buildid": "20160510030710", 04:41:28 INFO - "pgo_build": "False", 04:41:28 INFO - "basedir": "/builds/slave/test", 04:41:28 INFO - "buildnumber": 568, 04:41:28 INFO - "slavename": "talos-linux64-ix-024", 04:41:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:41:28 INFO - "platform": "ubuntu64_hw", 04:41:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:41:28 INFO - "branch": "mozilla-central", 04:41:28 INFO - "repo_path": "mozilla-central", 04:41:28 INFO - "revision": "1579b9e2e50f3a27ad02d58cc9170c91e0973fec", 04:41:28 INFO - "stage_platform": "linux64", 04:41:28 INFO - "builduid": "2365e4bf703b425484e5d911e00d7883", 04:41:28 INFO - "slavebuilddir": "test" 04:41:28 INFO - } 04:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:41:28 INFO - Running post-action listener: _resource_record_post_action 04:41:28 INFO - ##### 04:41:28 INFO - ##### Finished read-buildbot-config step (success) 04:41:28 INFO - ##### 04:41:28 INFO - ##### 04:41:28 INFO - ##### Running download-and-extract step. 04:41:28 INFO - ##### 04:41:28 INFO - Running pre-action listener: _resource_record_pre_action 04:41:28 INFO - Running main action method: download_and_extract 04:41:28 INFO - mkdir: /builds/slave/test/build/tests 04:41: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')]} 04:41:28 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:41:29 INFO - Downloaded 1361 bytes. 04:41:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:29 INFO - Using the following test package requirements: 04:41:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:41:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'jsshell-linux-x86_64.zip'], 04:41:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:29 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:41:30 INFO - Downloaded 22325729 bytes. 04:41:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:41:31 INFO - Return code: 0 04:41:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:31 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:41:33 INFO - Downloaded 22325729 bytes. 04:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:41:34 INFO - Return code: 0 04:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:34 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:41:35 INFO - Downloaded 10840152 bytes. 04:41:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:41:35 INFO - Return code: 0 04:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:35 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:41:38 INFO - Downloaded 54673617 bytes. 04:41:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:38 INFO - mkdir: /builds/slave/test/properties 04:41:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:38 INFO - Contents: 04:41:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:39 INFO - Running post-action listener: _resource_record_post_action 04:41:39 INFO - Running post-action listener: set_extra_try_arguments 04:41:39 INFO - ##### 04:41:39 INFO - ##### Finished download-and-extract step (success) 04:41:39 INFO - ##### 04:41:39 INFO - ##### 04:41:39 INFO - ##### Running populate-webroot step. 04:41:39 INFO - ##### 04:41:39 INFO - Running pre-action listener: _resource_record_pre_action 04:41:39 INFO - Running main action method: populate_webroot 04:41:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:39 INFO - '--tppagecycles', 04:41:39 INFO - '7'], 04:41:39 INFO - 'tests': ['tsvgm']}}, 04:41:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:41:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:41:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:41:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:41:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['damp', 'tps']}, 04:41:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'tests': ['damp', 'tps']}, 04:41:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['dromaeo_dom']}, 04:41:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['a11yr', 04:41:39 INFO - 'ts_paint', 04:41:39 INFO - 'tpaint', 04:41:39 INFO - 'sessionrestore', 04:41:39 INFO - 'sessionrestore_no_auto_restore', 04:41:39 INFO - 'tabpaint']}, 04:41:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['tsvgx', 04:41:39 INFO - 'tsvgr_opacity', 04:41:39 INFO - 'tart', 04:41:39 INFO - 'tscrollx', 04:41:39 INFO - 'cart']}, 04:41:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:41:39 INFO - 'tsvgr_opacity', 04:41:39 INFO - 'tart', 04:41:39 INFO - 'tscrollx', 04:41:39 INFO - 'cart']}, 04:41:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'talos_options': ['--disable-e10s'], 04:41:39 INFO - 'tests': ['tp5o']}, 04:41:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'tests': ['tp5o']}, 04:41:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'talos_options': ['--disable-e10s', 04:41:39 INFO - '--xperf_path', 04:41:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:39 INFO - 'tests': ['tp5n']}, 04:41:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:39 INFO - 'talos_options': ['--xperf_path', 04:41:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:39 INFO - 'tests': ['tp5n']}}, 04:41:39 INFO - 'talos.zip': {'path': '', 04:41:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:39 INFO - Running post-action listener: _resource_record_post_action 04:41:39 INFO - ##### 04:41:39 INFO - ##### Finished populate-webroot step (success) 04:41:39 INFO - ##### 04:41:39 INFO - ##### 04:41:39 INFO - ##### Running create-virtualenv step. 04:41:39 INFO - ##### 04:41:39 INFO - Running pre-action listener: _resource_record_pre_action 04:41:39 INFO - Running main action method: create_virtualenv 04:41:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:39 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 04:41:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:39 INFO - Using real prefix '/usr' 04:41:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:42 INFO - Installing pip.................done. 04:41:42 INFO - Return code: 0 04:41:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:42 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:42 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 04:41:42 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 04:41:42 INFO - Using env: {'DISPLAY': ':0', 04:41:42 INFO - 'HOME': '/home/cltbld', 04:41:42 INFO - 'LANG': 'en_US.UTF-8', 04:41:42 INFO - 'LANGUAGE': 'en_US:en', 04:41:42 INFO - 'LOGNAME': 'cltbld', 04:41:42 INFO - 'MAIL': '/var/mail/cltbld', 04:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:42 INFO - 'MOZ_NO_REMOTE': '1', 04:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:42 INFO - 'NO_EM_RESTART': '1', 04:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:42 INFO - 'PWD': '/builds/slave/test', 04:41:42 INFO - 'SHELL': '/bin/bash', 04:41:42 INFO - 'SHLVL': '1', 04:41:42 INFO - 'TERM': 'linux', 04:41:42 INFO - 'TMOUT': '86400', 04:41:42 INFO - 'USER': 'cltbld', 04:41:42 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:42 INFO - '_': '/tools/buildbot/bin/python'} 04:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:41:42 INFO - Cleaning up... 04:41:42 INFO - Return code: 0 04:41:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:42 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:42 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 04:41:42 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 04:41:42 INFO - Using env: {'DISPLAY': ':0', 04:41:42 INFO - 'HOME': '/home/cltbld', 04:41:42 INFO - 'LANG': 'en_US.UTF-8', 04:41:42 INFO - 'LANGUAGE': 'en_US:en', 04:41:42 INFO - 'LOGNAME': 'cltbld', 04:41:42 INFO - 'MAIL': '/var/mail/cltbld', 04:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:42 INFO - 'MOZ_NO_REMOTE': '1', 04:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:42 INFO - 'NO_EM_RESTART': '1', 04:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:42 INFO - 'PWD': '/builds/slave/test', 04:41:42 INFO - 'SHELL': '/bin/bash', 04:41:42 INFO - 'SHLVL': '1', 04:41:42 INFO - 'TERM': 'linux', 04:41:42 INFO - 'TMOUT': '86400', 04:41:42 INFO - 'USER': 'cltbld', 04:41:42 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:42 INFO - '_': '/tools/buildbot/bin/python'} 04:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:42 INFO - Downloading/unpacking psutil>=0.7.1 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:44 INFO - Installing collected packages: psutil 04:41:44 INFO - Running setup.py install for psutil 04:41:44 INFO - building 'psutil._psutil_linux' extension 04:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:41:44 INFO - building 'psutil._psutil_posix' extension 04:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:44 INFO - Successfully installed psutil 04:41:44 INFO - Cleaning up... 04:41:45 INFO - Return code: 0 04:41:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:45 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:45 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 04:41:45 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 04:41:45 INFO - Using env: {'DISPLAY': ':0', 04:41:45 INFO - 'HOME': '/home/cltbld', 04:41:45 INFO - 'LANG': 'en_US.UTF-8', 04:41:45 INFO - 'LANGUAGE': 'en_US:en', 04:41:45 INFO - 'LOGNAME': 'cltbld', 04:41:45 INFO - 'MAIL': '/var/mail/cltbld', 04:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:45 INFO - 'MOZ_NO_REMOTE': '1', 04:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:45 INFO - 'NO_EM_RESTART': '1', 04:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:45 INFO - 'PWD': '/builds/slave/test', 04:41:45 INFO - 'SHELL': '/bin/bash', 04:41:45 INFO - 'SHLVL': '1', 04:41:45 INFO - 'TERM': 'linux', 04:41:45 INFO - 'TMOUT': '86400', 04:41:45 INFO - 'USER': 'cltbld', 04:41:45 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:45 INFO - '_': '/tools/buildbot/bin/python'} 04:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:41:47 INFO - Installing collected packages: mozsystemmonitor 04:41:47 INFO - Running setup.py install for mozsystemmonitor 04:41:47 INFO - Successfully installed mozsystemmonitor 04:41:47 INFO - Cleaning up... 04:41:47 INFO - Return code: 0 04:41:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:47 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:47 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 04:41:47 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 04:41:47 INFO - Using env: {'DISPLAY': ':0', 04:41:47 INFO - 'HOME': '/home/cltbld', 04:41:47 INFO - 'LANG': 'en_US.UTF-8', 04:41:47 INFO - 'LANGUAGE': 'en_US:en', 04:41:47 INFO - 'LOGNAME': 'cltbld', 04:41:47 INFO - 'MAIL': '/var/mail/cltbld', 04:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:47 INFO - 'MOZ_NO_REMOTE': '1', 04:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:47 INFO - 'NO_EM_RESTART': '1', 04:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:47 INFO - 'PWD': '/builds/slave/test', 04:41:47 INFO - 'SHELL': '/bin/bash', 04:41:47 INFO - 'SHLVL': '1', 04:41:47 INFO - 'TERM': 'linux', 04:41:47 INFO - 'TMOUT': '86400', 04:41:47 INFO - 'USER': 'cltbld', 04:41:47 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:47 INFO - '_': '/tools/buildbot/bin/python'} 04:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:50 INFO - Downloading docopt-0.6.1.tar.gz 04:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:50 INFO - Running setup.py install for blobuploader 04:41:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:50 INFO - Running setup.py install for requests 04:41:50 INFO - Running setup.py install for docopt 04:41:50 INFO - Successfully installed blobuploader requests docopt 04:41:50 INFO - Cleaning up... 04:41:50 INFO - Return code: 0 04:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:50 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 04:41:50 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 04:41:50 INFO - Using env: {'DISPLAY': ':0', 04:41:50 INFO - 'HOME': '/home/cltbld', 04:41:50 INFO - 'LANG': 'en_US.UTF-8', 04:41:50 INFO - 'LANGUAGE': 'en_US:en', 04:41:50 INFO - 'LOGNAME': 'cltbld', 04:41:50 INFO - 'MAIL': '/var/mail/cltbld', 04:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:50 INFO - 'MOZ_NO_REMOTE': '1', 04:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:50 INFO - 'NO_EM_RESTART': '1', 04:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:50 INFO - 'PWD': '/builds/slave/test', 04:41:50 INFO - 'SHELL': '/bin/bash', 04:41:50 INFO - 'SHLVL': '1', 04:41:50 INFO - 'TERM': 'linux', 04:41:50 INFO - 'TMOUT': '86400', 04:41:50 INFO - 'USER': 'cltbld', 04:41:50 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:50 INFO - '_': '/tools/buildbot/bin/python'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:50 INFO - Running setup.py (path:/tmp/pip-9j7Mg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:50 INFO - Running setup.py (path:/tmp/pip-IO63zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:51 INFO - Running setup.py (path:/tmp/pip-gLTr2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:51 INFO - Running setup.py (path:/tmp/pip-RR5Nij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:51 INFO - Running setup.py (path:/tmp/pip-f1SXHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:51 INFO - Running setup.py (path:/tmp/pip-NjLwpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:51 INFO - Running setup.py (path:/tmp/pip-HOHdDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:51 INFO - Running setup.py (path:/tmp/pip-V_VcjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:51 INFO - Running setup.py (path:/tmp/pip-kUhnT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:51 INFO - Running setup.py (path:/tmp/pip-bfjtny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:51 INFO - Running setup.py (path:/tmp/pip-IyJIAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:51 INFO - Running setup.py (path:/tmp/pip-Oeopjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:51 INFO - Running setup.py (path:/tmp/pip-oN0CMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:51 INFO - Running setup.py (path:/tmp/pip-WC_Ri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:51 INFO - Running setup.py (path:/tmp/pip-n9kVLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:52 INFO - Running setup.py (path:/tmp/pip-Udvn8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:52 INFO - Running setup.py (path:/tmp/pip-NVq57F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:52 INFO - Running setup.py install for manifestparser 04:41:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Running setup.py install for mozcrash 04:41:52 INFO - Running setup.py install for mozdebug 04:41:52 INFO - Running setup.py install for mozdevice 04:41:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Running setup.py install for mozfile 04:41:52 INFO - Running setup.py install for mozhttpd 04:41:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Running setup.py install for mozinfo 04:41:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Running setup.py install for mozInstall 04:41:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:52 INFO - Running setup.py install for mozleak 04:41:53 INFO - Running setup.py install for mozlog 04:41:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Running setup.py install for moznetwork 04:41:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Running setup.py install for mozprocess 04:41:53 INFO - Running setup.py install for mozprofile 04:41:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Running setup.py install for mozrunner 04:41:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Running setup.py install for mozscreenshot 04:41:53 INFO - Running setup.py install for moztest 04:41:53 INFO - Running setup.py install for mozversion 04:41:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:53 INFO - Cleaning up... 04:41:53 INFO - Return code: 0 04:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:53 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:53 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 04:41:53 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 04:41:53 INFO - Using env: {'DISPLAY': ':0', 04:41:53 INFO - 'HOME': '/home/cltbld', 04:41:53 INFO - 'LANG': 'en_US.UTF-8', 04:41:53 INFO - 'LANGUAGE': 'en_US:en', 04:41:53 INFO - 'LOGNAME': 'cltbld', 04:41:53 INFO - 'MAIL': '/var/mail/cltbld', 04:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:53 INFO - 'MOZ_NO_REMOTE': '1', 04:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:53 INFO - 'NO_EM_RESTART': '1', 04:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:53 INFO - 'PWD': '/builds/slave/test', 04:41:53 INFO - 'SHELL': '/bin/bash', 04:41:53 INFO - 'SHLVL': '1', 04:41:53 INFO - 'TERM': 'linux', 04:41:53 INFO - 'TMOUT': '86400', 04:41:53 INFO - 'USER': 'cltbld', 04:41:53 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:53 INFO - '_': '/tools/buildbot/bin/python'} 04:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:54 INFO - Running setup.py (path:/tmp/pip-vo6Gh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:54 INFO - Running setup.py (path:/tmp/pip-nZQJxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:54 INFO - Running setup.py (path:/tmp/pip-bmDGJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:54 INFO - Running setup.py (path:/tmp/pip-_vWN0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:54 INFO - Running setup.py (path:/tmp/pip-6CfZ9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:54 INFO - Running setup.py (path:/tmp/pip-NjgMb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:54 INFO - Running setup.py (path:/tmp/pip-zaYNqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:54 INFO - Running setup.py (path:/tmp/pip-2YOoMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:54 INFO - Running setup.py (path:/tmp/pip-1y_CRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:54 INFO - Running setup.py (path:/tmp/pip-Ls9OuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:54 INFO - Running setup.py (path:/tmp/pip-fEntmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:54 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)) 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:54 INFO - Running setup.py (path:/tmp/pip-synM7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:55 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)) 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:55 INFO - Running setup.py (path:/tmp/pip-k04ZJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:55 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)) 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:55 INFO - Running setup.py (path:/tmp/pip-2oKC4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:55 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)) 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:55 INFO - Running setup.py (path:/tmp/pip-IXTuY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:55 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)) 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:55 INFO - Running setup.py (path:/tmp/pip-wPMhBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:55 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)) 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:55 INFO - Running setup.py (path:/tmp/pip-H0l5EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:55 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)) 04:41:55 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)) 04:41:55 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)) 04:41:55 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)) 04:41:55 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)) 04:41:55 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)) 04:41:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:57 INFO - Downloading blessings-1.6.tar.gz 04:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:57 INFO - Installing collected packages: blessings 04:41:57 INFO - Running setup.py install for blessings 04:41:57 INFO - Successfully installed blessings 04:41:57 INFO - Cleaning up... 04:41:57 INFO - Return code: 0 04:41:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:57 INFO - Reading from file tmpfile_stdout 04:41:57 INFO - Current package versions: 04:41:57 INFO - argparse == 1.2.1 04:41:57 INFO - blessings == 1.6 04:41:57 INFO - blobuploader == 1.2.4 04:41:57 INFO - docopt == 0.6.1 04:41:57 INFO - manifestparser == 1.1 04:41:57 INFO - mozInstall == 1.12 04:41:57 INFO - mozcrash == 0.17 04:41:57 INFO - mozdebug == 0.1 04:41:57 INFO - mozdevice == 0.48 04:41:57 INFO - mozfile == 1.2 04:41:57 INFO - mozhttpd == 0.7 04:41:57 INFO - mozinfo == 0.9 04:41:57 INFO - mozleak == 0.1 04:41:57 INFO - mozlog == 3.1 04:41:57 INFO - moznetwork == 0.27 04:41:57 INFO - mozprocess == 0.22 04:41:57 INFO - mozprofile == 0.28 04:41:57 INFO - mozrunner == 6.11 04:41:57 INFO - mozscreenshot == 0.1 04:41:57 INFO - mozsystemmonitor == 0.0 04:41:57 INFO - moztest == 0.7 04:41:57 INFO - mozversion == 1.4 04:41:57 INFO - psutil == 3.1.1 04:41:57 INFO - requests == 1.2.3 04:41:57 INFO - wsgiref == 0.1.2 04:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:57 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:57 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 04:41:57 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 04:41:57 INFO - Using env: {'DISPLAY': ':0', 04:41:57 INFO - 'HOME': '/home/cltbld', 04:41:57 INFO - 'LANG': 'en_US.UTF-8', 04:41:57 INFO - 'LANGUAGE': 'en_US:en', 04:41:57 INFO - 'LOGNAME': 'cltbld', 04:41:57 INFO - 'MAIL': '/var/mail/cltbld', 04:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:57 INFO - 'MOZ_NO_REMOTE': '1', 04:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:57 INFO - 'NO_EM_RESTART': '1', 04:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:57 INFO - 'PWD': '/builds/slave/test', 04:41:57 INFO - 'SHELL': '/bin/bash', 04:41:57 INFO - 'SHLVL': '1', 04:41:57 INFO - 'TERM': 'linux', 04:41:57 INFO - 'TMOUT': '86400', 04:41:57 INFO - 'USER': 'cltbld', 04:41:57 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:57 INFO - '_': '/tools/buildbot/bin/python'} 04:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 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)) 04:41:57 INFO - Cleaning up... 04:41:57 INFO - Return code: 0 04:41:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:57 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:41:57 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 04:41:57 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 04:41:57 INFO - Using env: {'DISPLAY': ':0', 04:41:57 INFO - 'HOME': '/home/cltbld', 04:41:57 INFO - 'LANG': 'en_US.UTF-8', 04:41:57 INFO - 'LANGUAGE': 'en_US:en', 04:41:57 INFO - 'LOGNAME': 'cltbld', 04:41:57 INFO - 'MAIL': '/var/mail/cltbld', 04:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:57 INFO - 'MOZ_NO_REMOTE': '1', 04:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:57 INFO - 'NO_EM_RESTART': '1', 04:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:57 INFO - 'PWD': '/builds/slave/test', 04:41:57 INFO - 'SHELL': '/bin/bash', 04:41:57 INFO - 'SHLVL': '1', 04:41:57 INFO - 'TERM': 'linux', 04:41:57 INFO - 'TMOUT': '86400', 04:41:57 INFO - 'USER': 'cltbld', 04:41:57 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:57 INFO - '_': '/tools/buildbot/bin/python'} 04:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:58 INFO - Downloading/unpacking jsonschema 04:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:00 INFO - warning: no files found matching '*.txt' 04:42:00 INFO - no previously-included directories found matching 'build' 04:42:00 INFO - no previously-included directories found matching 'dist' 04:42:00 INFO - no previously-included directories found matching '.git*' 04:42:00 INFO - Installing collected packages: jsonschema, functools32 04:42:00 INFO - Running setup.py install for functools32 04:42:00 INFO - warning: no files found matching '*.txt' 04:42:00 INFO - no previously-included directories found matching 'build' 04:42:00 INFO - no previously-included directories found matching 'dist' 04:42:00 INFO - no previously-included directories found matching '.git*' 04:42:00 INFO - Successfully installed jsonschema functools32 04:42:00 INFO - Cleaning up... 04:42:00 INFO - Return code: 0 04:42:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:00 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 0x7f4820edaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', '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 04:42:00 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 04:42:00 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 04:42:00 INFO - Using env: {'DISPLAY': ':0', 04:42:00 INFO - 'HOME': '/home/cltbld', 04:42:00 INFO - 'LANG': 'en_US.UTF-8', 04:42:00 INFO - 'LANGUAGE': 'en_US:en', 04:42:00 INFO - 'LOGNAME': 'cltbld', 04:42:00 INFO - 'MAIL': '/var/mail/cltbld', 04:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:00 INFO - 'MOZ_NO_REMOTE': '1', 04:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:00 INFO - 'NO_EM_RESTART': '1', 04:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:00 INFO - 'PWD': '/builds/slave/test', 04:42:00 INFO - 'SHELL': '/bin/bash', 04:42:00 INFO - 'SHLVL': '1', 04:42:00 INFO - 'TERM': 'linux', 04:42:00 INFO - 'TMOUT': '86400', 04:42:00 INFO - 'USER': 'cltbld', 04:42:00 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:00 INFO - '_': '/tools/buildbot/bin/python'} 04:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:00 INFO - Downloading/unpacking flake8 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:03 INFO - no previously-included directories found matching 'docs/_build' 04:42:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:03 INFO - Running setup.py install for pep8 04:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:03 INFO - no previously-included directories found matching 'docs/_build' 04:42:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:42:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:03 INFO - Cleaning up... 04:42:03 INFO - Return code: 0 04:42:03 INFO - Running post-action listener: _resource_record_post_action 04:42:03 INFO - Running post-action listener: _start_resource_monitoring 04:42:03 INFO - Starting resource monitoring. 04:42:03 INFO - ##### 04:42:03 INFO - ##### Finished create-virtualenv step (success) 04:42:03 INFO - ##### 04:42:03 INFO - ##### 04:42:03 INFO - ##### Running install step. 04:42:03 INFO - ##### 04:42:03 INFO - Running pre-action listener: _resource_record_pre_action 04:42:03 INFO - Running main action method: install 04:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:03 INFO - Reading from file tmpfile_stdout 04:42:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:04 INFO - Reading from file tmpfile_stdout 04:42:04 INFO - Output received: 04:42:04 INFO - Usage: mozinstall [options] installer 04:42:04 INFO - Options: 04:42:04 INFO - -h, --help show this help message and exit 04:42:04 INFO - -d DEST, --destination=DEST 04:42:04 INFO - Directory to install application into. [default: 04:42:04 INFO - "/builds/slave/test"] 04:42:04 INFO - --app=APP Application being installed. [default: firefox] 04:42:04 INFO - mkdir: /builds/slave/test/build/application 04:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:42:19 INFO - Reading from file tmpfile_stdout 04:42:19 INFO - Output received: 04:42:19 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:19 INFO - Running post-action listener: _resource_record_post_action 04:42:19 INFO - ##### 04:42:19 INFO - ##### Finished install step (success) 04:42:19 INFO - ##### 04:42:19 INFO - ##### 04:42:19 INFO - ##### Running run-tests step. 04:42:19 INFO - ##### 04:42:19 INFO - Running pre-action listener: _resource_record_pre_action 04:42:19 INFO - Running main action method: run_tests 04:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:19 INFO - Python 2.7.3 04:42:19 INFO - Return code: 0 04:42:19 INFO - grabbing minidump binary from tooltool 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 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 0x1b469c0>, '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 0x1b478c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b47d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:19 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 04:42:19 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 04:42:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:19 INFO - Return code: 0 04:42:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:42:20 INFO - Return code: 0 04:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:42:20 INFO - Using env: {'DISPLAY': ':0', 04:42:20 INFO - 'HOME': '/home/cltbld', 04:42:20 INFO - 'LANG': 'en_US.UTF-8', 04:42:20 INFO - 'LANGUAGE': 'en_US:en', 04:42:20 INFO - 'LOGNAME': 'cltbld', 04:42:20 INFO - 'MAIL': '/var/mail/cltbld', 04:42:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:20 INFO - 'MOZ_NO_REMOTE': '1', 04:42:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:20 INFO - 'NO_EM_RESTART': '1', 04:42:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:20 INFO - 'PWD': '/builds/slave/test', 04:42:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:20 INFO - 'SHELL': '/bin/bash', 04:42:20 INFO - 'SHLVL': '1', 04:42:20 INFO - 'TERM': 'linux', 04:42:20 INFO - 'TMOUT': '86400', 04:42:20 INFO - 'USER': 'cltbld', 04:42:20 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883', 04:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:20 INFO - '_': '/tools/buildbot/bin/python'} 04:42:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:42:20 INFO - mozversion application_buildid: 20160510030710 04:42:20 INFO - mozversion application_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 04:42:20 INFO - mozversion application_display_name: Nightly 04:42:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:20 INFO - mozversion application_name: Firefox 04:42:20 INFO - mozversion application_remotingname: firefox 04:42:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:42:20 INFO - mozversion application_vendor: Mozilla 04:42:20 INFO - mozversion application_version: 49.0a1 04:42:20 INFO - mozversion platform_buildid: 20160510030710 04:42:20 INFO - mozversion platform_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 04:42:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:42:20 INFO - mozversion platform_version: 49.0a1 04:42:20 INFO - using testdate: 1462880540 04:42:20 INFO - actual date: 1462880540 04:42:20 INFO - starting webserver on 'localhost:47221' 04:42:20 INFO - SUITE-START | Running 2 tests 04:42:20 INFO - TEST-START | dromaeo_css 04:42:20 INFO - operating with platform_type : linux_ 04:42:20 INFO - Initialising browser for dromaeo_css test... 04:42:20 INFO - TEST-INFO | started process 32205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUAEcNn/profile http://localhost:47221/getInfo.html) 04:42:25 INFO - PROCESS | 32205 | __metrics Screen width/height:1600/1200 04:42:25 INFO - PROCESS | 32205 | colorDepth:24 04:42:25 INFO - PROCESS | 32205 | Browser inner width/height: 1024/697 04:42:25 INFO - PROCESS | 32205 | __metrics 04:42:26 ERROR - PROCESS | 32205 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:42:26 INFO - TEST-INFO | 32205: exit 0 04:42:26 INFO - Browser initialized. 04:42:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:26 INFO - TEST-INFO | started process 32286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUAEcNn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:38 INFO - PROCESS | 32286 | RSS: Main: 153944064 04:42:38 INFO - PROCESS | 32286 | 04:43:30 INFO - PROCESS | 32286 | 1462880610329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:45:41 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47221/tests/dromaeo/cssquery-ext.html) 04:45:42 INFO - PROCESS | 32286 | RSS: Main: 240185344 04:45:42 INFO - PROCESS | 32286 | 04:48:45 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-ext.html (next: http://localhost:47221/tests/dromaeo/cssquery-jquery.html) 04:48:45 INFO - PROCESS | 32286 | RSS: Main: 234397696 04:48:45 INFO - PROCESS | 32286 | 04:51:47 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47221/tests/dromaeo/cssquery-mootools.html) 04:51:48 INFO - PROCESS | 32286 | RSS: Main: 243064832 04:51:48 INFO - PROCESS | 32286 | 04:54:50 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47221/tests/dromaeo/cssquery-prototype.html) 04:54:51 INFO - PROCESS | 32286 | RSS: Main: 231616512 04:54:51 INFO - PROCESS | 32286 | 04:57:54 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47221/tests/dromaeo/cssquery-yui.html) 04:57:54 INFO - PROCESS | 32286 | RSS: Main: 209342464 04:57:54 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | Cycle 1(1): loaded http://localhost:47221/tests/dromaeo/cssquery-yui.html (next: http://localhost:47221/tests/dromaeo/cssquery-dojo.html) 05:00:57 INFO - PROCESS | 32286 | RSS: Main: 268005376 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | __start_tp_report 05:00:57 INFO - PROCESS | 32286 | _x_x_mozilla_page_load 05:00:57 INFO - PROCESS | 32286 | _x_x_mozilla_page_load_details 05:00:57 INFO - PROCESS | 32286 | |i|pagename|runs| 05:00:57 INFO - PROCESS | 32286 | |0;dojo.html;2641.4585010072938;2657.2559683288687;2688.045743760965;2696.7033626301104;2699.6355492008574;4589.380433641458;4646.163690535702;4649.721016738994;4699.694519856212;4757.0961517311725;4653.790579423926;4697.4597921239065;4699.318598803172;4704.106219818232;4709.693869898454;4299.978500107495;4348.760818155;4399.274119770234;4426.955730442686;4488.012637219823;4390.143921935224;4395.86812395627;4403.493598236196;4417.977910110445;4453.242948698729;4198.349255865331;4260.0414906646065;4263.744175349489;4299.419578356913;4368.5194628590825;4245.639120674747;4259.659227261812;4312.353147027971;4318.417013703172;4332;4289.399484072202;4311.116221174651;4319.416878721395;4333.826646934119;4354.042110735633;4549.9990002199465;4564;4608.516105808875;4611.723296602215;4659.347691323217;5006.824761133343;5009.398872135367;5022.84931452057;5028.924566131511;5067.189249720064;4986.027724593706;5046;5052.747362631853;5058.291839142523;5093.949060509384;4666.556677115668;4688.109259240768;4692.507286734912;4714.457837348748;4767.594754445841;5174.844754657366;5193.662411943212;5211.817586384458;5216.26972223889;5218.765155568009;4887.413510378707;4948.65359424844;5033.471485494044;5056.064628043824;5109.054824857339;5043.218301163252;5079.568236699922;5084.288199652052;5092.490750924878;5133.23001549763;5057.342545469139;5065.442801291855;5070.163423035232;5072.594192464594;5115.923261151086;4846.975765121152;4857.344258525124;4868.926966095441;5047.747612619354;5069.138246498104;4237.609155069964;4259.339802330644;4260.595243451867;4293.677974151951;4296.591823776736;3695.74129810916;3700.3154416433044;3702.9444558331647;3745.9063523412133;3756.380197267475;4250.277452833026;4268.509121451073;4272.252355837716;4314.546972567898;4316.525182229952;5033.874153146201;5053.646244762905;5063.139266324733;5063.746812659352;5102.515261050195;4306.655467562588;4308.870733877989;4311.094670119247;4354.782260886943;4359.455068116486;4468.687191896536;4522.547745225517;4549.931751023737;4551.135284295973;4576.4737055239075;4737.360456338351;4737.620990320835;4749.620030397629;4752.786124624331;4799.640026997919;5054.924176137434;5062.873428164326;5065.620078494054;5072.67027643202;5118.744062796771;4653.139169253699;4689.2497200449125;4723.126221649006;4724.858254252378;4737.194676905004;4950.727709975986;4964.3298154748645;4979.402471703419;4984.601231901367;5026.723530205873;5014;5014.623903207347;5030.547250747451;5046.1926091825135;5101.46434624374;4868.391451068616;4879.56083952446;4930.6795058321095;4930.852074437773;4953.950460495349;4949.505049495022;4950;4953.504649535162;4953.777080031479;4998.850034498971;4715.174844402284;4772;4875.366202393666;4878.682885612424;4935.037667654773;4910.263460480956;4921.704697718148;4940.481249468754;4949.826756063664;4992.975035124947;4813.085513752376;4821.132196204717;4827.61379089679;4832.49258827818;4882.90234195307 05:00:57 INFO - PROCESS | 32286 | |1;ext.html;559.278530695403;586.2759492027346;598.6677394046303;600.5255847880175;609.7408601344428;29290.70709292909;32049.67950320496;41777;42615.78692106543;42793.78603106988;42521;42759.35860962088;42863.57136428635;42905;42935.78532107335;7973.963384759973;8098.554579498125;8111.310538604226;8121.984751906011;8144.877826832602;7904.525728456311;8003.5197888126895;8004.679812807481;8006.55963921984;8011.399145064114;8044.758657240292;8073.878891816627;8077.434579579432;8080.272775450208;8087.47431416959;7993.2806047455715;8031.2771850533145;8033.196680331978;8035.276825085741;8038.437309388345;7990.760277191694;8071.273585377344;8079.757607271791;8080.030396352417;8083.353331733447;39349.40975885364;39692.60307396947;39704;39717.602823971676;39810.40284395737;3111.4088323218516;3149.2126968257935;3199.96800031999;3213.1806389370795;3362.697357237836;29346.70653293461;29859;30550.236244093852;30758.23104422385;31511.054668359986;2852.8288302701903;2944.969260758717;2966.0953409210183;2970.9554356684666;2994.086803524924;256956;257063;257808;258994;259672;52160.47839521632;52649.2102618461;52656.47343526516;52672.73663631657;52774.20838687423;35509;36659.083522911606;36830.81584592113;38038.239235215144;38115;15750.369985200692;15780.210989450481;15793;15847.683046339009;15884.841151588336;12172.939135304267;12249.203801752858;12253.326067066397;12257.570985015482;12287.631371058882;19150.616987660447;19182.472625881288;19245.615087698166;19290.324838630582;19501.147390997834;7120.715171393086;7213.422926165894;7317.524360916524;7419.2209817969415;7430.591317477482;892.9241014513839;948.3693343926212;1015.7054454208345;1022.9028242316969;1066.4454483668449;28551.57172642412;28828.567571486445;29004;29311.120666380044;29557.556636650468;938.5354249646468;958.9696558873925;995.9900400996042;1019.3730855523947;1083.8590983172294;15288.770668439982;15519.456819011506;15588.298526566332;15907.920460397623;15931.203439827963;358865;360783;361405;364184;365855;51174.744126279875;51640.48359516432;51674.48325516772;51703;51786.482135178165;1172.6716519374588;1262.1039062265895;1264.4120483974812;1273.5924504158581;1303.0357535423907;29453.26366840846;30038.54942175913;30518.084457466313;30685;30930.381392372477;44580.33129503125;44851.775741121084;45238;45241.32138017998;45356;275553;276292;276968;277062;277778;24737.381565461008;26030.73969260283;26707.06525271684;27079;27106.186814395598;43941.560584395025;44178.55821441745;44629.55370446254;45131.77434112808;45995.77002114968;36602.45096323611;37556.436653450764;37715;38000.23999520049;38693.22613547769;37026.814865925495;37047.81476092602;37282.81358593189;37300.813495933435;38067;36755;36985.55965645221;37112.628873712;37365.626343736214;37515.06212344713;32589.18527036748;33961;34042.65957340395;34383.4842477358;34427.65572344245;25614.61578076293;25665.69008789218;25785.613215802154;26023.869880651233;26168 05:00:57 INFO - PROCESS | 32286 | |2;jquery.html;387.2680633602491;388.4968965190079;390.25850883321704;399.9340108882035;403.8970062634028;16220.756688649664;17642.558936026606;18243.543911402223;18290.90854545727;18298.08509574521;16903.83096169038;17183.484495465123;18081.909590452062;18121.275148994024;18122.909385453087;5153.330067091273;5319.7340132993195;5339.919901201485;5351.839444816662;5355.946440535603;3639.6906262967545;3785.6403641653997;6136.662483563402;6199.0391489319;6222.160008398853;6026.246719160105;6164.229471316085;6179.443850053494;6187.907181392283;6191.721372538246;5998.130271110708;6120.051392034242;6239.500839932794;6242.937570624304;6243.625382477043;5453.345598528163;5463.836084917419;5468.945310546884;5476.069068258405;5476.205950137248;19085.80914190868;20231.494212644655;21162.153513859426;21252.893735531223;21310;1764.1091248919213;1876.8310852023383;1917.166032775747;2095.298075144828;2307.4462129088897;9276.675316363895;9457.763555911088;9490.90509094907;9684.03159684033;11901.226420282741;1760.9735853962202;1790.9910450447794;1805.7652505174374;1808.4303444414968;1817.4638481647946;68961.65519172422;69361.95957060598;69408;69575;70411.64794176047;10294.948525257325;10348.741281467874;10490.16078713701;10556.26106172576;10596.15230781551;14512.662087719884;14631.634209144644;14673.119612823264;14675.266236688123;14706.33821478036;7283.126024876943;7700.422468314899;7771.378289736807;7876.448648594658;7889.9211007890335;7383.486385291002;7385.81535461607;7495.587742674205;7600.2779735925;7648.42636802242;4420.977895110504;4482.148391805546;4533.161365147458;4621.5378462154185;4646.883827904262;1858.7583614130076;1861.944141675752;1872.6722823505831;1880.2760937039338;1980.7623085229864;807.0557447785988;935.1583574782615;968.5157421289356;985.2413641496008;989.4211886046743;16452.506424807274;16915.492535223962;17128.914355428144;17247.137643117792;17790.46628601144;916.0930678628243;927.0405130689704;930.4882314727008;933.5052422216236;997.5112195024531;9654.082862128087;9845.753856153653;9900.554475048497;10007.44959027246;10067.194624430029;377532;399959;400610;401966;402122;46028.76985615117;48440;78034.60982695164;80829.59585202036;81412;962.9903700962901;967.032967032967;974.1476208317722;988.5699720621552;988.7824678570703;15630.296636651605;15704.60738481547;15777.290021948811;15833.68332633364;16119.758203627189;33892.83053584716;35312.47031294584;35736.821315893256;36105.81947090353;36351.63648363482;45002.3249651262;50878.74560627173;50930.236046458595;51105.488945110075;51235;5268.367795864521;7738.535687858746;7893.921060789318;8029.076656184614;8162.795930101795;7327.37717294036;10070.496475176358;11503.194776365573;11906.642800715992;12341.50633974667;10317.123044541298;10786.191035672513;10955.014048735333;11039.944800275947;11092;10217.591296348062;10379.11777498921;10476.423796691255;10957.780844383227;10992.17558683118;10325.535350909377;10572.524236409226;10777.676669699922;11086.833697494383;11500.25248358854;7783.827987872976;8001.399895008014;8085.757427277191;8264.83470330602;8446.450980686235;10901.618443354444;11122.277051991594;11127.332360058099;11147;11305.943470282597 05:00:57 INFO - PROCESS | 32286 | |3;mootools.html;1307.22220278934;1478.3347493627866;1518.2029434546862;1695.2371432855218;1853.1568136497895;6963.930360696391;7277.090363704537;7278.053852999109;7446.292602202782;7452.664630091645;7264.418846492281;7376.446766492508;7414.629268536579;7443.478956473049;7448.217937116592;2199.637059885121;2226.053927080984;2239.4177513846353;2239.675247089171;2249.808766254862;2174.5759576882515;2207.7792220777956;2221.178164079293;2224.3104637562406;2228.242397584821;2118.682197670354;2119.067610251492;2146.527763891941;2159.503314237726;2169.674548817682;2086.8330533557278;2103.4951611613255;2105.210546045233;2105.336818902056;2109.947251318714;2022.33263023202;2085.48905518149;2090.4773806548365;2091.1321801452377;2092.23633373819;7189.496735228536;7279.199288078307;7279.2356802535505;7362.37419819316;7544.547327160388;4514;4585.449746030497;4608.400907881954;4624.05206932578;4630.282306242538;2815.8873645054173;2868.512352899991;2895;2906.869190886394;2944.7791415643696;876.3120950054241;885.9468431894107;889.4352086425102;900.1673452056821;913.392593925039;9933.80132397348;10018.549165287579;10059.5473203706;10064.144547713453;10072.899271007343;4032.9798351008058;4097.221527909747;4166.291730405838;4170.7706076166105;4184.686148538872;8028.558429286329;8059.63731632078;8068.757937261891;8070.717524886601;8073.7577872663915;4510.503844577094;4518.909621807546;4524.04994951064;4556.134334476439;4558.566936141061;3603.837827297778;4042.777647229431;4078;4120.320147175742;4185;3355.1612096975755;3382.5433566468214;3440.8623655053516;3464.757466977338;3474.8957531274104;996.8853581838182;999.550202408919;1001.3491230700104;1009.9798004039878;1044.0864243786687;773.6479901644739;792.4136139256908;797.5334429358774;827.0571548434789;846.8645016797283;4709.128811169944;4731.33761273422;4744.857654270378;4766.737829419346;4873.074115917964;849.2059923971107;857.4598003258033;881.8192270584515;897.8339007283673;906.4864249699447;3389.57630296213;3418.6410426905313;3425.092350527112;3447.844846981892;3486.093615659947;8686.087960764155;8837.072107428756;9151.17639412456;9163.81672366549;9169.908300917039;9047.230985366186;9060.637574497077;9062.410943288665;9068.22920051803;9069.637214511346;6876.140482439695;6966.721331146698;7012.333828286304;7079.823004424828;7204.0994875640545;4815.277708343637;4899.804007839646;4922.335484709662;4935.851924442272;4972.328735620645;8299.95850020746;8354.122817104117;8446.873296900674;8481.703140390056;8483.575821208791;8438.915610843813;8542.871856922275;8599.312055035458;8619.525926073875;8659;5172.9741351293005;5303.337082864642;5304.151335786256;5962.284525856925;6089;6034.09488576717;6600.438962688033;6765.42493888025;6771.62756048422;6954.547954382949;6014.939850601613;6303.306636270098;6331.398517140864;6332.683365831598;6523.445507131947;6328.778492752732;6390.233172019201;6397.6481293529305;6468.514861385321;6550.181227346582;5887.381824908323;5892.086726557391;5945.167676525203;5953.91069133972;5955.196048533393;4161.334186530141;4183.435236243068;4219.07180420307;4258.61672449481;4300.526942036436;4292.334688123346;4315.741055536678;4324.027093903846;4407;4457.7771111444945 05:00:57 INFO - PROCESS | 32286 | |4;prototype.html;310.4071223962232;317.363685809951;318.5031351092296;319.788939300062;322.1141859885315;4623.514530974246;4837.685550439219;4848.96939412867;4862.440819305781;4872.7563621818945;4698;4706.8352607658735;4742.8223090529345;4757.191277482828;4763.309320148576;3493.842777075025;3598.6941110005682;3605.1708107135373;3678.6089042122567;3724.571674257468;3697.9815100924457;3708.7033037356946;3711.2206436648203;3711.8329675164546;3717.4609681596153;3670.1191713988583;3671.8531258749617;3683.4843121962945;3688.3360995020885;3694.6305369463107;3460.307938412315;3565.628856810218;3702.9444558331647;3708.740388172829;3712.109093817491;3234.256121092162;3247.8376081195847;3259.3318369734384;3266.2814180880405;3288.408086544421;4563.406757121586;4563.498015218323;4576.54234576543;4577.427821522309;4582.518835522255;3940.2119576084897;4186.497620285555;4252.617264446215;4255.212785634668;4264.33902745075;4943.184374578191;4959.132151873444;4959.16510890969;4960.925586116211;4984.775685094143;3459.705924996353;3473.4442489201606;3477.7217822574135;3491.4937334086417;3494.0391392367046;4945.085159245515;5168;5185.533302002837;5200.089984252779;5212.322398088262;3611.259691763182;3618.9276214475562;3632.6730594246646;3640.690541304019;3647.8905632831056;3684.9815750921075;3697.6487233712755;3709.221063576625;3724.832382542792;3733.4692775962267;4151.958480415157;4208.705390622627;4242.66058715302;4253.425787518708;4262.168877069003;4927.77824997876;4947.727874966911;4963.379577552806;4975.850724478271;4983.750812459362;1262.551794113095;1268.346801397281;1272.4973635414144;1272.5164437513686;1274.5857596281246;808.6280311056979;814.1370147643516;834.7495751274594;860.3676297921023;874.2394117118148;4315.633171180422;4331.371951067078;4336.739795612273;4364.650827933758;4365.716228445141;5049.823256186016;5065.265536497187;5067.746612669352;5082.313887625123;5087.364079490064;4209.642180414638;4385.671074669349;4411.911761764747;4424.84513042042;4432.601065904084;2704.9729502705113;2729.6178535005115;2747.766439852595;2749.780017598587;2773.7642300404286;4841.540053694894;4844.588210002189;4860.781264843091;4861.927071093936;4880.536349046835;5031.4213865405945;5245.4788111448015;5249.370075590953;5292.280008997014;5309.522143007148;4792.904141917142;4800.4479484859685;4800.823798169401;4804.591609713214;4832.613390928787;5108.795648174031;5109.7700603472185;5128.4615115413835;5133.383993920754;5136.30659860929;4846.297286893451;5063.772130254074;5073.2897394365555;5081.136206844919;5086.6439349246675;4845;4849.927251091307;4862.465128835896;4863.294822250825;4863.829765958175;3656.3418584653955;3658.5975542690817;3691.114132608101;3691.132583842741;3694.519712437366;4941.678790878582;5141.511556402136;5186.351706036746;5200.6619569727845;5204.713740744295;4924.359833221658;4960.379952505937;4968.701877887338;4979.228219625964;4979.502049795136;4948.727819969936;4951.480094590016;4951.554360107608;4952.900941981068;4955.851324460272;4662.950836061859;4910.2880082388565;4911.537366156779;4911.705297682151;4918.458969513422;4799.736014519235;4857.2714092884935;4975.253711943237;4989.376327959005;4999.300097986357;4860.513948605111;4863.683860549053;4880.365552478155;4905.043516514245;4908.582770464551 05:00:57 INFO - PROCESS | 32286 | |5;yui.html;670.3229737964655;700.9544379615321;708;709.7303024850556;755.8412733326002;10401.739956501091;10501;10509;11966.162368634199;12660.936695316534;13598.18410895347;13652.522161724342;13675.384607692678;13698.863011369884;13724.65688357789;687.336720065137;848.8981322241309;878.2096113497839;884.3014018925041;884.3986089459165;868.891388576428;876.132628697588;876.1895246896627;876.4084243135858;876.4609764994515;895.9104089591021;911.731039343392;912.4798864647154;912.4935660708304;912.803747194353;724.409606170969;882.170759486081;910.8588168833842;911.0115524655723;911.8404279251138;677.5426587053719;678.1387637700093;678.3420082519948;678.5555461172939;678.5691086160274;10820.621278255223;10877.07544858688;10935.83596246057;10939.398333091676;10958.780824383468;10257.43584102874;10892.074173695246;10929.945350273198;11160.107191424666;11327.603533876358;9753.366031207948;9920.305578609501;9925.3548519346;10013.799724005552;10114.54484548197;4077.734947228421;4084.6323830855367;4087.550369459357;4100.2414553307435;4158.064435502018;44969.325460118125;44996.55003449956;45173.096538069054;45201;45412.772936135436;9160.083991600786;9246.7110477096;9327.673531426502;9368.156865882103;9425.05749425052;16587.419440319532;16606.335746570243;16610;16613;16629.417970370978;6251.74993000284;6307.905381419282;6311.96844015777;6402.871942561216;6441.1626488556185;3228.6287076985977;3328.234506063619;3481.4255647817827;3602.2975519773395;3662.633736626316;2770.362816552204;2867.4551835151674;2874.568814677815;2876.194665493665;2880.265532289253;409.24085820801986;505.5273319446329;511.4655185331338;511.5800871176199;516.388080125053;525.8001959255535;545.7707762739659;553.8310815201322;560.882214734902;571.134730882713;6198.721057552421;6291.496680265568;6383.872322553523;6384.201974753156;6412.935870641327;468.5759387754088;504.6064070025386;509.98512959210905;514.1952843799442;556.3185098254687;3665.321915445651;3706.5181526401934;3712.3688972874675;3714.46140309659;3821.6942644588366;51998.48001520012;52486;55135;55186;55404.72297638567;47296.344627937855;48611.756941215775;48793.512064878894;49453.25820112701;50153.49846501488;45248.3212751809;45500.08999819985;45589;45997.08005839864;46423.76788116105;6861.931380686129;7063.223045465097;7118.074650295428;7257.2742725727;7895.84208315842;26674.33314167084;26731.465370692866;27675.169744907686;27936;29661.555076673434;38655.6134438652;39606.60393396144;40041.59958400379;40136.19727605373;40216.79891600523;10383.376997380181;10435.895641043493;10461.215408844519;10625.574977000833;10756;11091.611793587186;11139.387333696724;11420.371879546372;12091;12331.938340308241;10395.688129356131;10865;10922.781544368909;11440.485178166837;11460.426978651201;9443.622255109718;9549.713508594754;9900.158486528439;9982.60069597237;10130.594776208869;10382.169426446017;10425.165986720893;10599.735006624587;11009.174311926477;11190.216684831983;9260.30547708911;9289.674861379819;9360.391574547633;9375.34372593912;9611.327207095435;8754.08082151365;8984.05667404913;8988.505632190292;9057.909420905706;9215.124563166488 05:00:57 INFO - PROCESS | 32286 | __end_tp_report 05:00:57 INFO - PROCESS | 32286 | __start_cc_report 05:00:57 INFO - PROCESS | 32286 | _x_x_mozilla_cycle_collect,871 05:00:57 INFO - PROCESS | 32286 | __end_cc_report 05:00:57 INFO - PROCESS | 32286 | __startTimestamp1462881657545__endTimestamp 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | ------- Summary: start ------- 05:00:57 INFO - PROCESS | 32286 | Number of tests: 6 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#0] dojo.html Cycles:165 Average:4656.70 Median:4752.79 stddev:489.11 (10.3%) stddev-sans-first:464.36 05:00:57 INFO - PROCESS | 32286 | Values: 2641.5 2657.3 2688.0 2696.7 2699.6 4589.4 4646.2 4649.7 4699.7 4757.1 4653.8 4697.5 4699.3 4704.1 4709.7 4300.0 4348.8 4399.3 4427.0 4488.0 4390.1 4395.9 4403.5 4418.0 4453.2 4198.3 4260.0 4263.7 4299.4 4368.5 4245.6 4259.7 4312.4 4318.4 4332.0 4289.4 4311.1 4319.4 4333.8 4354.0 4550.0 4564.0 4608.5 4611.7 4659.3 5006.8 5009.4 5022.8 5028.9 5067.2 4986.0 5046.0 5052.7 5058.3 5093.9 4666.6 4688.1 4692.5 4714.5 4767.6 5174.8 5193.7 5211.8 5216.3 5218.8 4887.4 4948.7 5033.5 5056.1 5109.1 5043.2 5079.6 5084.3 5092.5 5133.2 5057.3 5065.4 5070.2 5072.6 5115.9 4847.0 4857.3 4868.9 5047.7 5069.1 4237.6 4259.3 4260.6 4293.7 4296.6 3695.7 3700.3 3702.9 3745.9 3756.4 4250.3 4268.5 4272.3 4314.5 4316.5 5033.9 5053.6 5063.1 5063.7 5102.5 4306.7 4308.9 4311.1 4354.8 4359.5 4468.7 4522.5 4549.9 4551.1 4576.5 4737.4 4737.6 4749.6 4752.8 4799.6 5054.9 5062.9 5065.6 5072.7 5118.7 4653.1 4689.2 4723.1 4724.9 4737.2 4950.7 4964.3 4979.4 4984.6 5026.7 5014.0 5014.6 5030.5 5046.2 5101.5 4868.4 4879.6 4930.7 4930.9 4954.0 4949.5 4950.0 4953.5 4953.8 4998.9 4715.2 4772.0 4875.4 4878.7 4935.0 4910.3 4921.7 4940.5 4949.8 4993.0 4813.1 4821.1 4827.6 4832.5 4882.9 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#1] ext.html Cycles:180 Average:46022.05 Median:36792.91 stddev:79218.20 (215.3%) stddev-sans-first:79366.89 05:00:57 INFO - PROCESS | 32286 | Values: 559.3 586.3 598.7 600.5 609.7 29290.7 32049.7 41777.0 42615.8 42793.8 42521.0 42759.4 42863.6 42905.0 42935.8 7974.0 8098.6 8111.3 8122.0 8144.9 7904.5 8003.5 8004.7 8006.6 8011.4 8044.8 8073.9 8077.4 8080.3 8087.5 7993.3 8031.3 8033.2 8035.3 8038.4 7990.8 8071.3 8079.8 8080.0 8083.4 39349.4 39692.6 39704.0 39717.6 39810.4 3111.4 3149.2 3200.0 3213.2 3362.7 29346.7 29859.0 30550.2 30758.2 31511.1 2852.8 2945.0 2966.1 2971.0 2994.1 256956.0 257063.0 257808.0 258994.0 259672.0 52160.5 52649.2 52656.5 52672.7 52774.2 35509.0 36659.1 36830.8 38038.2 38115.0 15750.4 15780.2 15793.0 15847.7 15884.8 12172.9 12249.2 12253.3 12257.6 12287.6 19150.6 19182.5 19245.6 19290.3 19501.1 7120.7 7213.4 7317.5 7419.2 7430.6 892.9 948.4 1015.7 1022.9 1066.4 28551.6 28828.6 29004.0 29311.1 29557.6 938.5 959.0 996.0 1019.4 1083.9 15288.8 15519.5 15588.3 15907.9 15931.2 358865.0 360783.0 361405.0 364184.0 365855.0 51174.7 51640.5 51674.5 51703.0 51786.5 1172.7 1262.1 1264.4 1273.6 1303.0 29453.3 30038.5 30518.1 30685.0 30930.4 44580.3 44851.8 45238.0 45241.3 45356.0 275553.0 276292.0 276968.0 277062.0 277778.0 24737.4 26030.7 26707.1 27079.0 27106.2 43941.6 44178.6 44629.6 45131.8 45995.8 36602.5 37556.4 37715.0 38000.2 38693.2 37026.8 37047.8 37282.8 37300.8 38067.0 36755.0 36985.6 37112.6 37365.6 37515.1 32589.2 33961.0 34042.7 34383.5 34427.7 25614.6 25665.7 25785.6 26023.9 26168.0 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#2] jquery.html Cycles:180 Average:24408.04 Median:401288.00 stddev:65218.83 (16.3%) stddev-sans-first:65376.84 05:00:57 INFO - PROCESS | 32286 | Values: 387.3 388.5 390.3 399.9 403.9 16220.8 17642.6 18243.5 18290.9 18298.1 16903.8 17183.5 18081.9 18121.3 18122.9 5153.3 5319.7 5339.9 5351.8 5355.9 3639.7 3785.6 6136.7 6199.0 6222.2 6026.2 6164.2 6179.4 6187.9 6191.7 5998.1 6120.1 6239.5 6242.9 6243.6 5453.3 5463.8 5468.9 5476.1 5476.2 19085.8 20231.5 21162.2 21252.9 21310.0 1764.1 1876.8 1917.2 2095.3 2307.4 9276.7 9457.8 9490.9 9684.0 11901.2 1761.0 1791.0 1805.8 1808.4 1817.5 68961.7 69362.0 69408.0 69575.0 70411.6 10294.9 10348.7 10490.2 10556.3 10596.2 14512.7 14631.6 14673.1 14675.3 14706.3 7283.1 7700.4 7771.4 7876.4 7889.9 7383.5 7385.8 7495.6 7600.3 7648.4 4421.0 4482.1 4533.2 4621.5 4646.9 1858.8 1861.9 1872.7 1880.3 1980.8 807.1 935.2 968.5 985.2 989.4 16452.5 16915.5 17128.9 17247.1 17790.5 916.1 927.0 930.5 933.5 997.5 9654.1 9845.8 9900.6 10007.4 10067.2 377532.0 399959.0 400610.0 401966.0 402122.0 46028.8 48440.0 78034.6 80829.6 81412.0 963.0 967.0 974.1 988.6 988.8 15630.3 15704.6 15777.3 15833.7 16119.8 33892.8 35312.5 35736.8 36105.8 36351.6 45002.3 50878.7 50930.2 51105.5 51235.0 5268.4 7738.5 7893.9 8029.1 8162.8 7327.4 10070.5 11503.2 11906.6 12341.5 10317.1 10786.2 10955.0 11039.9 11092.0 10217.6 10379.1 10476.4 10957.8 10992.2 10325.5 10572.5 10777.7 11086.8 11500.3 7783.8 8001.4 8085.8 8264.8 8446.5 10901.6 11122.3 11127.3 11147.0 11305.9 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#3] mootools.html Cycles:180 Average:4839.00 Median:4954.09 stddev:2650.20 (53.5%) stddev-sans-first:2644.34 05:00:57 INFO - PROCESS | 32286 | Values: 1307.2 1478.3 1518.2 1695.2 1853.2 6963.9 7277.1 7278.1 7446.3 7452.7 7264.4 7376.4 7414.6 7443.5 7448.2 2199.6 2226.1 2239.4 2239.7 2249.8 2174.6 2207.8 2221.2 2224.3 2228.2 2118.7 2119.1 2146.5 2159.5 2169.7 2086.8 2103.5 2105.2 2105.3 2109.9 2022.3 2085.5 2090.5 2091.1 2092.2 7189.5 7279.2 7279.2 7362.4 7544.5 4514.0 4585.4 4608.4 4624.1 4630.3 2815.9 2868.5 2895.0 2906.9 2944.8 876.3 885.9 889.4 900.2 913.4 9933.8 10018.5 10059.5 10064.1 10072.9 4033.0 4097.2 4166.3 4170.8 4184.7 8028.6 8059.6 8068.8 8070.7 8073.8 4510.5 4518.9 4524.0 4556.1 4558.6 3603.8 4042.8 4078.0 4120.3 4185.0 3355.2 3382.5 3440.9 3464.8 3474.9 996.9 999.6 1001.3 1010.0 1044.1 773.6 792.4 797.5 827.1 846.9 4709.1 4731.3 4744.9 4766.7 4873.1 849.2 857.5 881.8 897.8 906.5 3389.6 3418.6 3425.1 3447.8 3486.1 8686.1 8837.1 9151.2 9163.8 9169.9 9047.2 9060.6 9062.4 9068.2 9069.6 6876.1 6966.7 7012.3 7079.8 7204.1 4815.3 4899.8 4922.3 4935.9 4972.3 8300.0 8354.1 8446.9 8481.7 8483.6 8438.9 8542.9 8599.3 8619.5 8659.0 5173.0 5303.3 5304.2 5962.3 6089.0 6034.1 6600.4 6765.4 6771.6 6954.5 6014.9 6303.3 6331.4 6332.7 6523.4 6328.8 6390.2 6397.6 6468.5 6550.2 5887.4 5892.1 5945.2 5953.9 5955.2 4161.3 4183.4 4219.1 4258.6 4300.5 4292.3 4315.7 4324.0 4407.0 4457.8 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#4] prototype.html Cycles:180 Average:4126.52 Median:4760.25 stddev:1197.52 (25.2%) stddev-sans-first:1166.12 05:00:57 INFO - PROCESS | 32286 | Values: 310.4 317.4 318.5 319.8 322.1 4623.5 4837.7 4849.0 4862.4 4872.8 4698.0 4706.8 4742.8 4757.2 4763.3 3493.8 3598.7 3605.2 3678.6 3724.6 3698.0 3708.7 3711.2 3711.8 3717.5 3670.1 3671.9 3683.5 3688.3 3694.6 3460.3 3565.6 3702.9 3708.7 3712.1 3234.3 3247.8 3259.3 3266.3 3288.4 4563.4 4563.5 4576.5 4577.4 4582.5 3940.2 4186.5 4252.6 4255.2 4264.3 4943.2 4959.1 4959.2 4960.9 4984.8 3459.7 3473.4 3477.7 3491.5 3494.0 4945.1 5168.0 5185.5 5200.1 5212.3 3611.3 3618.9 3632.7 3640.7 3647.9 3685.0 3697.6 3709.2 3724.8 3733.5 4152.0 4208.7 4242.7 4253.4 4262.2 4927.8 4947.7 4963.4 4975.9 4983.8 1262.6 1268.3 1272.5 1272.5 1274.6 808.6 814.1 834.7 860.4 874.2 4315.6 4331.4 4336.7 4364.7 4365.7 5049.8 5065.3 5067.7 5082.3 5087.4 4209.6 4385.7 4411.9 4424.8 4432.6 2705.0 2729.6 2747.8 2749.8 2773.8 4841.5 4844.6 4860.8 4861.9 4880.5 5031.4 5245.5 5249.4 5292.3 5309.5 4792.9 4800.4 4800.8 4804.6 4832.6 5108.8 5109.8 5128.5 5133.4 5136.3 4846.3 5063.8 5073.3 5081.1 5086.6 4845.0 4849.9 4862.5 4863.3 4863.8 3656.3 3658.6 3691.1 3691.1 3694.5 4941.7 5141.5 5186.4 5200.7 5204.7 4924.4 4960.4 4968.7 4979.2 4979.5 4948.7 4951.5 4951.6 4952.9 4955.9 4663.0 4910.3 4911.5 4911.7 4918.5 4799.7 4857.3 4975.3 4989.4 4999.3 4860.5 4863.7 4880.4 4905.0 4908.6 05:00:57 INFO - PROCESS | 32286 | 05:00:57 INFO - PROCESS | 32286 | [#5] yui.html Cycles:180 Average:12677.29 Median:47954.05 stddev:14907.62 (31.1%) stddev-sans-first:14922.18 05:00:57 INFO - PROCESS | 32286 | Values: 670.3 701.0 708.0 709.7 755.8 10401.7 10501.0 10509.0 11966.2 12660.9 13598.2 13652.5 13675.4 13698.9 13724.7 687.3 848.9 878.2 884.3 884.4 868.9 876.1 876.2 876.4 876.5 895.9 911.7 912.5 912.5 912.8 724.4 882.2 910.9 911.0 911.8 677.5 678.1 678.3 678.6 678.6 10820.6 10877.1 10935.8 10939.4 10958.8 10257.4 10892.1 10929.9 11160.1 11327.6 9753.4 9920.3 9925.4 10013.8 10114.5 4077.7 4084.6 4087.6 4100.2 4158.1 44969.3 44996.6 45173.1 45201.0 45412.8 9160.1 9246.7 9327.7 9368.2 9425.1 16587.4 16606.3 16610.0 16613.0 16629.4 6251.7 6307.9 6312.0 6402.9 6441.2 3228.6 3328.2 3481.4 3602.3 3662.6 2770.4 2867.5 2874.6 2876.2 2880.3 409.2 505.5 511.5 511.6 516.4 525.8 545.8 553.8 560.9 571.1 6198.7 6291.5 6383.9 6384.2 6412.9 468.6 504.6 510.0 514.2 556.3 3665.3 3706.5 3712.4 3714.5 3821.7 51998.5 52486.0 55135.0 55186.0 55404.7 47296.3 48611.8 48793.5 49453.3 50153.5 45248.3 45500.1 45589.0 45997.1 46423.8 6861.9 7063.2 7118.1 7257.3 7895.8 26674.3 26731.5 27675.2 27936.0 29661.6 38655.6 39606.6 40041.6 40136.2 40216.8 10383.4 10435.9 10461.2 10625.6 10756.0 11091.6 11139.4 11420.4 12091.0 12331.9 10395.7 10865.0 10922.8 11440.5 11460.4 9443.6 9549.7 9900.2 9982.6 10130.6 10382.2 10425.2 10599.7 11009.2 11190.2 9260.3 9289.7 9360.4 9375.3 9611.3 8754.1 8984.1 8988.5 9057.9 9215.1 05:00:57 INFO - PROCESS | 32286 | -------- Summary: end -------- 05:00:57 INFO - PROCESS | 32286 | 05:00:58 INFO - TEST-INFO | 32286: exit 0 05:00:58 INFO - TEST-OK | dromaeo_css | took 1117382ms 05:00:58 INFO - TEST-START | kraken 05:00:58 INFO - operating with platform_type : linux_ 05:00:58 INFO - Initialising browser for kraken test... 05:00:58 INFO - TEST-INFO | started process 32461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN2qEQ/profile http://localhost:47221/getInfo.html) 05:01:02 INFO - PROCESS | 32461 | __metrics Screen width/height:1600/1200 05:01:02 INFO - PROCESS | 32461 | colorDepth:24 05:01:02 INFO - PROCESS | 32461 | Browser inner width/height: 1024/697 05:01:02 INFO - PROCESS | 32461 | __metrics 05:01:03 ERROR - PROCESS | 32461 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:01:04 INFO - TEST-INFO | 32461: exit 0 05:01:04 INFO - Browser initialized. 05:01:04 INFO - Running cycle 1/1 for kraken test... 05:01:04 INFO - TEST-INFO | started process 32544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN2qEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:16 INFO - PROCESS | 32544 | RSS: Main: 154161152 05:01:16 INFO - PROCESS | 32544 | 05:01:18 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47221/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:19 INFO - PROCESS | 32544 | RSS: Main: 209539072 05:01:19 INFO - PROCESS | 32544 | 05:01:22 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47221/tests/kraken/driver.html?testName=audio-dft) 05:01:23 INFO - PROCESS | 32544 | RSS: Main: 197308416 05:01:23 INFO - PROCESS | 32544 | 05:01:26 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47221/tests/kraken/driver.html?testName=audio-fft) 05:01:27 INFO - PROCESS | 32544 | RSS: Main: 266387456 05:01:27 INFO - PROCESS | 32544 | 05:01:29 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47221/tests/kraken/driver.html?testName=audio-oscillator) 05:01:30 INFO - PROCESS | 32544 | RSS: Main: 175026176 05:01:30 INFO - PROCESS | 32544 | 05:01:32 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47221/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:33 INFO - PROCESS | 32544 | RSS: Main: 178831360 05:01:33 INFO - PROCESS | 32544 | 05:01:36 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47221/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:36 INFO - PROCESS | 32544 | RSS: Main: 215199744 05:01:36 INFO - PROCESS | 32544 | 05:01:40 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47221/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:41 INFO - PROCESS | 32544 | RSS: Main: 214085632 05:01:41 INFO - PROCESS | 32544 | 05:01:44 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47221/tests/kraken/driver.html?testName=json-parse-financial) 05:01:44 INFO - PROCESS | 32544 | RSS: Main: 214491136 05:01:44 INFO - PROCESS | 32544 | 05:01:46 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47221/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:47 INFO - PROCESS | 32544 | RSS: Main: 210083840 05:01:47 INFO - PROCESS | 32544 | 05:01:49 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:49 INFO - PROCESS | 32544 | RSS: Main: 210276352 05:01:49 INFO - PROCESS | 32544 | 05:01:52 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:52 INFO - PROCESS | 32544 | RSS: Main: 212611072 05:01:52 INFO - PROCESS | 32544 | 05:01:55 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:56 INFO - PROCESS | 32544 | RSS: Main: 218591232 05:01:56 INFO - PROCESS | 32544 | 05:01:59 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:00 INFO - PROCESS | 32544 | RSS: Main: 217374720 05:02:00 INFO - PROCESS | 32544 | 05:02:01 INFO - PROCESS | 32544 | Cycle 1(1): loaded http://localhost:47221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47221/tests/kraken/driver.html?testName=ai-astar) 05:02:02 INFO - PROCESS | 32544 | RSS: Main: 262754304 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | __start_tp_report 05:02:02 INFO - PROCESS | 32544 | _x_x_mozilla_page_load 05:02:02 INFO - PROCESS | 32544 | _x_x_mozilla_page_load_details 05:02:02 INFO - PROCESS | 32544 | |i|pagename|runs| 05:02:02 INFO - PROCESS | 32544 | |0;ai-astar;116;110;114;115;113;112;112;112;112;111 05:02:02 INFO - PROCESS | 32544 | |1;audio-beat-detection;156;128;155;207;131;152;155;131;194;129 05:02:02 INFO - PROCESS | 32544 | |2;audio-dft;161;161;161;164;163;161;161;160;162;161 05:02:02 INFO - PROCESS | 32544 | |3;audio-fft;76;76;75;154;79;75;86;75;132;75 05:02:02 INFO - PROCESS | 32544 | |4;audio-oscillator;93;93;152;93;94;93;131;93;93;120 05:02:02 INFO - PROCESS | 32544 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 05:02:02 INFO - PROCESS | 32544 | |6;imaging-darkroom;147;146;145;146;145;146;145;146;146;146 05:02:02 INFO - PROCESS | 32544 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;95;95 05:02:02 INFO - PROCESS | 32544 | |8;json-parse-financial;68;67;67;66;66;67;67;67;66;67 05:02:02 INFO - PROCESS | 32544 | |9;json-stringify-tinderbox;63;65;64;64;63;64;69;64;63;63 05:02:02 INFO - PROCESS | 32544 | |10;stanford-crypto-aes;98;82;83;81;84;84;85;91;173;84 05:02:02 INFO - PROCESS | 32544 | |11;stanford-crypto-ccm;135;141;141;137;130;139;132;131;157;141 05:02:02 INFO - PROCESS | 32544 | |12;stanford-crypto-pbkdf2;182;181;175;182;178;176;184;181;174;176 05:02:02 INFO - PROCESS | 32544 | |13;stanford-crypto-sha256-iterative;71;70;69;67;70;68;76;75;67;67 05:02:02 INFO - PROCESS | 32544 | __end_tp_report 05:02:02 INFO - PROCESS | 32544 | __start_cc_report 05:02:02 INFO - PROCESS | 32544 | _x_x_mozilla_cycle_collect,2067 05:02:02 INFO - PROCESS | 32544 | __end_cc_report 05:02:02 INFO - PROCESS | 32544 | __startTimestamp1462881722127__endTimestamp 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | ------- Summary: start ------- 05:02:02 INFO - PROCESS | 32544 | Number of tests: 14 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:1.83 (1.6%) stddev-sans-first:1.50 05:02:02 INFO - PROCESS | 32544 | Values: 116.0 110.0 114.0 115.0 113.0 112.0 112.0 112.0 112.0 111.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:155.00 stddev:27.44 (17.7%) stddev-sans-first:29.10 05:02:02 INFO - PROCESS | 32544 | Values: 156.0 128.0 155.0 207.0 131.0 152.0 155.0 131.0 194.0 129.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 05:02:02 INFO - PROCESS | 32544 | Values: 161.0 161.0 161.0 164.0 163.0 161.0 161.0 160.0 162.0 161.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#3] audio-fft Cycles:10 Average:90.30 Median:75.50 stddev:28.46 (37.7%) stddev-sans-first:29.71 05:02:02 INFO - PROCESS | 32544 | Values: 76.0 76.0 75.0 154.0 79.0 75.0 86.0 75.0 132.0 75.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:21.32 (22.9%) stddev-sans-first:22.13 05:02:02 INFO - PROCESS | 32544 | Values: 93.0 93.0 152.0 93.0 94.0 93.0 131.0 93.0 93.0 120.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:02:02 INFO - PROCESS | 32544 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 05:02:02 INFO - PROCESS | 32544 | Values: 147.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:02:02 INFO - PROCESS | 32544 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 05:02:02 INFO - PROCESS | 32544 | Values: 68.0 67.0 67.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.87 05:02:02 INFO - PROCESS | 32544 | Values: 63.0 65.0 64.0 64.0 63.0 64.0 69.0 64.0 63.0 63.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:84.00 stddev:28.04 (33.4%) stddev-sans-first:29.72 05:02:02 INFO - PROCESS | 32544 | Values: 98.0 82.0 83.0 81.0 84.0 84.0 85.0 91.0 173.0 84.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:140.00 stddev:7.79 (5.6%) stddev-sans-first:8.17 05:02:02 INFO - PROCESS | 32544 | Values: 135.0 141.0 141.0 137.0 130.0 139.0 132.0 131.0 157.0 141.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:181.00 stddev:3.51 (1.9%) stddev-sans-first:3.54 05:02:02 INFO - PROCESS | 32544 | Values: 182.0 181.0 175.0 182.0 178.0 176.0 184.0 181.0 174.0 176.0 05:02:02 INFO - PROCESS | 32544 | 05:02:02 INFO - PROCESS | 32544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:3.23 (4.6%) stddev-sans-first:3.41 05:02:02 INFO - PROCESS | 32544 | Values: 71.0 70.0 69.0 67.0 70.0 68.0 76.0 75.0 67.0 67.0 05:02:02 INFO - PROCESS | 32544 | -------- Summary: end -------- 05:02:02 INFO - PROCESS | 32544 | 05:02:03 INFO - TEST-INFO | 32544: exit 0 05:02:03 INFO - TEST-OK | kraken | took 64844ms 05:02:03 INFO - SUITE-END | took 1182s 05:02:03 INFO - Completed test suite (00:19:42) 05:02:03 INFO - javascript benchmark 05:02:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.4585010072938, 2657.2559683288687, 2688.045743760965, 2696.7033626301104, 2699.6355492008574, 4589.380433641458, 4646.163690535702, 4649.721016738994, 4699.694519856212, 4757.0961517311725, 4653.790579423926, 4697.4597921239065, 4699.318598803172, 4704.106219818232, 4709.693869898454, 4299.978500107495, 4348.760818155, 4399.274119770234, 4426.955730442686, 4488.012637219823, 4390.143921935224, 4395.86812395627, 4403.493598236196, 4417.977910110445, 4453.242948698729, 4198.349255865331, 4260.0414906646065, 4263.744175349489, 4299.419578356913, 4368.5194628590825, 4245.639120674747, 4259.659227261812, 4312.353147027971, 4318.417013703172, 4332.0, 4289.399484072202, 4311.116221174651, 4319.416878721395, 4333.826646934119, 4354.042110735633, 4549.9990002199465, 4564.0, 4608.516105808875, 4611.723296602215, 4659.347691323217, 5006.824761133343, 5009.398872135367, 5022.84931452057, 5028.924566131511, 5067.189249720064, 4986.027724593706, 5046.0, 5052.747362631853, 5058.291839142523, 5093.949060509384, 4666.556677115668, 4688.109259240768, 4692.507286734912, 4714.457837348748, 4767.594754445841, 5174.844754657366, 5193.662411943212, 5211.817586384458, 5216.26972223889, 5218.765155568009, 4887.413510378707, 4948.65359424844, 5033.471485494044, 5056.064628043824, 5109.054824857339, 5043.218301163252, 5079.568236699922, 5084.288199652052, 5092.490750924878, 5133.23001549763, 5057.342545469139, 5065.442801291855, 5070.163423035232, 5072.594192464594, 5115.923261151086, 4846.975765121152, 4857.344258525124, 4868.926966095441, 5047.747612619354, 5069.138246498104, 4237.609155069964, 4259.339802330644, 4260.595243451867, 4293.677974151951, 4296.591823776736, 3695.74129810916, 3700.3154416433044, 3702.9444558331647, 3745.9063523412133, 3756.380197267475, 4250.277452833026, 4268.509121451073, 4272.252355837716, 4314.546972567898, 4316.525182229952, 5033.874153146201, 5053.646244762905, 5063.139266324733, 5063.746812659352, 5102.515261050195, 4306.655467562588, 4308.870733877989, 4311.094670119247, 4354.782260886943, 4359.455068116486, 4468.687191896536, 4522.547745225517, 4549.931751023737, 4551.135284295973, 4576.4737055239075, 4737.360456338351, 4737.620990320835, 4749.620030397629, 4752.786124624331, 4799.640026997919, 5054.924176137434, 5062.873428164326, 5065.620078494054, 5072.67027643202, 5118.744062796771, 4653.139169253699, 4689.2497200449125, 4723.126221649006, 4724.858254252378, 4737.194676905004, 4950.727709975986, 4964.3298154748645, 4979.402471703419, 4984.601231901367, 5026.723530205873, 5014.0, 5014.623903207347, 5030.547250747451, 5046.1926091825135, 5101.46434624374, 4868.391451068616, 4879.56083952446, 4930.6795058321095, 4930.852074437773, 4953.950460495349, 4949.505049495022, 4950.0, 4953.504649535162, 4953.777080031479, 4998.850034498971, 4715.174844402284, 4772.0, 4875.366202393666, 4878.682885612424, 4935.037667654773, 4910.263460480956, 4921.704697718148, 4940.481249468754, 4949.826756063664, 4992.975035124947, 4813.085513752376, 4821.132196204717, 4827.61379089679, 4832.49258827818, 4882.90234195307], "value": 4625.8161545258745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.278530695403, 586.2759492027346, 598.6677394046303, 600.5255847880175, 609.7408601344428, 29290.70709292909, 32049.67950320496, 41777.0, 42615.78692106543, 42793.78603106988, 42521.0, 42759.35860962088, 42863.57136428635, 42905.0, 42935.78532107335, 7973.963384759973, 8098.554579498125, 8111.310538604226, 8121.984751906011, 8144.877826832602, 7904.525728456311, 8003.5197888126895, 8004.679812807481, 8006.55963921984, 8011.399145064114, 8044.758657240292, 8073.878891816627, 8077.434579579432, 8080.272775450208, 8087.47431416959, 7993.2806047455715, 8031.2771850533145, 8033.196680331978, 8035.276825085741, 8038.437309388345, 7990.760277191694, 8071.273585377344, 8079.757607271791, 8080.030396352417, 8083.353331733447, 39349.40975885364, 39692.60307396947, 39704.0, 39717.602823971676, 39810.40284395737, 3111.4088323218516, 3149.2126968257935, 3199.96800031999, 3213.1806389370795, 3362.697357237836, 29346.70653293461, 29859.0, 30550.236244093852, 30758.23104422385, 31511.054668359986, 2852.8288302701903, 2944.969260758717, 2966.0953409210183, 2970.9554356684666, 2994.086803524924, 256956.0, 257063.0, 257808.0, 258994.0, 259672.0, 52160.47839521632, 52649.2102618461, 52656.47343526516, 52672.73663631657, 52774.20838687423, 35509.0, 36659.083522911606, 36830.81584592113, 38038.239235215144, 38115.0, 15750.369985200692, 15780.210989450481, 15793.0, 15847.683046339009, 15884.841151588336, 12172.939135304267, 12249.203801752858, 12253.326067066397, 12257.570985015482, 12287.631371058882, 19150.616987660447, 19182.472625881288, 19245.615087698166, 19290.324838630582, 19501.147390997834, 7120.715171393086, 7213.422926165894, 7317.524360916524, 7419.2209817969415, 7430.591317477482, 892.9241014513839, 948.3693343926212, 1015.7054454208345, 1022.9028242316969, 1066.4454483668449, 28551.57172642412, 28828.567571486445, 29004.0, 29311.120666380044, 29557.556636650468, 938.5354249646468, 958.9696558873925, 995.9900400996042, 1019.3730855523947, 1083.8590983172294, 15288.770668439982, 15519.456819011506, 15588.298526566332, 15907.920460397623, 15931.203439827963, 358865.0, 360783.0, 361405.0, 364184.0, 365855.0, 51174.744126279875, 51640.48359516432, 51674.48325516772, 51703.0, 51786.482135178165, 1172.6716519374588, 1262.1039062265895, 1264.4120483974812, 1273.5924504158581, 1303.0357535423907, 29453.26366840846, 30038.54942175913, 30518.084457466313, 30685.0, 30930.381392372477, 44580.33129503125, 44851.775741121084, 45238.0, 45241.32138017998, 45356.0, 275553.0, 276292.0, 276968.0, 277062.0, 277778.0, 24737.381565461008, 26030.73969260283, 26707.06525271684, 27079.0, 27106.186814395598, 43941.560584395025, 44178.55821441745, 44629.55370446254, 45131.77434112808, 45995.77002114968, 36602.45096323611, 37556.436653450764, 37715.0, 38000.23999520049, 38693.22613547769, 37026.814865925495, 37047.81476092602, 37282.81358593189, 37300.813495933435, 38067.0, 36755.0, 36985.55965645221, 37112.628873712, 37365.626343736214, 37515.06212344713, 32589.18527036748, 33961.0, 34042.65957340395, 34383.4842477358, 34427.65572344245, 25614.61578076293, 25665.69008789218, 25785.613215802154, 26023.869880651233, 26168.0], "value": 17823.380559508547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.2680633602491, 388.4968965190079, 390.25850883321704, 399.9340108882035, 403.8970062634028, 16220.756688649664, 17642.558936026606, 18243.543911402223, 18290.90854545727, 18298.08509574521, 16903.83096169038, 17183.484495465123, 18081.909590452062, 18121.275148994024, 18122.909385453087, 5153.330067091273, 5319.7340132993195, 5339.919901201485, 5351.839444816662, 5355.946440535603, 3639.6906262967545, 3785.6403641653997, 6136.662483563402, 6199.0391489319, 6222.160008398853, 6026.246719160105, 6164.229471316085, 6179.443850053494, 6187.907181392283, 6191.721372538246, 5998.130271110708, 6120.051392034242, 6239.500839932794, 6242.937570624304, 6243.625382477043, 5453.345598528163, 5463.836084917419, 5468.945310546884, 5476.069068258405, 5476.205950137248, 19085.80914190868, 20231.494212644655, 21162.153513859426, 21252.893735531223, 21310.0, 1764.1091248919213, 1876.8310852023383, 1917.166032775747, 2095.298075144828, 2307.4462129088897, 9276.675316363895, 9457.763555911088, 9490.90509094907, 9684.03159684033, 11901.226420282741, 1760.9735853962202, 1790.9910450447794, 1805.7652505174374, 1808.4303444414968, 1817.4638481647946, 68961.65519172422, 69361.95957060598, 69408.0, 69575.0, 70411.64794176047, 10294.948525257325, 10348.741281467874, 10490.16078713701, 10556.26106172576, 10596.15230781551, 14512.662087719884, 14631.634209144644, 14673.119612823264, 14675.266236688123, 14706.33821478036, 7283.126024876943, 7700.422468314899, 7771.378289736807, 7876.448648594658, 7889.9211007890335, 7383.486385291002, 7385.81535461607, 7495.587742674205, 7600.2779735925, 7648.42636802242, 4420.977895110504, 4482.148391805546, 4533.161365147458, 4621.5378462154185, 4646.883827904262, 1858.7583614130076, 1861.944141675752, 1872.6722823505831, 1880.2760937039338, 1980.7623085229864, 807.0557447785988, 935.1583574782615, 968.5157421289356, 985.2413641496008, 989.4211886046743, 16452.506424807274, 16915.492535223962, 17128.914355428144, 17247.137643117792, 17790.46628601144, 916.0930678628243, 927.0405130689704, 930.4882314727008, 933.5052422216236, 997.5112195024531, 9654.082862128087, 9845.753856153653, 9900.554475048497, 10007.44959027246, 10067.194624430029, 377532.0, 399959.0, 400610.0, 401966.0, 402122.0, 46028.76985615117, 48440.0, 78034.60982695164, 80829.59585202036, 81412.0, 962.9903700962901, 967.032967032967, 974.1476208317722, 988.5699720621552, 988.7824678570703, 15630.296636651605, 15704.60738481547, 15777.290021948811, 15833.68332633364, 16119.758203627189, 33892.83053584716, 35312.47031294584, 35736.821315893256, 36105.81947090353, 36351.63648363482, 45002.3249651262, 50878.74560627173, 50930.236046458595, 51105.488945110075, 51235.0, 5268.367795864521, 7738.535687858746, 7893.921060789318, 8029.076656184614, 8162.795930101795, 7327.37717294036, 10070.496475176358, 11503.194776365573, 11906.642800715992, 12341.50633974667, 10317.123044541298, 10786.191035672513, 10955.014048735333, 11039.944800275947, 11092.0, 10217.591296348062, 10379.11777498921, 10476.423796691255, 10957.780844383227, 10992.17558683118, 10325.535350909377, 10572.524236409226, 10777.676669699922, 11086.833697494383, 11500.25248358854, 7783.827987872976, 8001.399895008014, 8085.757427277191, 8264.83470330602, 8446.450980686235, 10901.618443354444, 11122.277051991594, 11127.332360058099, 11147.0, 11305.943470282597], "value": 8480.473379194598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.22220278934, 1478.3347493627866, 1518.2029434546862, 1695.2371432855218, 1853.1568136497895, 6963.930360696391, 7277.090363704537, 7278.053852999109, 7446.292602202782, 7452.664630091645, 7264.418846492281, 7376.446766492508, 7414.629268536579, 7443.478956473049, 7448.217937116592, 2199.637059885121, 2226.053927080984, 2239.4177513846353, 2239.675247089171, 2249.808766254862, 2174.5759576882515, 2207.7792220777956, 2221.178164079293, 2224.3104637562406, 2228.242397584821, 2118.682197670354, 2119.067610251492, 2146.527763891941, 2159.503314237726, 2169.674548817682, 2086.8330533557278, 2103.4951611613255, 2105.210546045233, 2105.336818902056, 2109.947251318714, 2022.33263023202, 2085.48905518149, 2090.4773806548365, 2091.1321801452377, 2092.23633373819, 7189.496735228536, 7279.199288078307, 7279.2356802535505, 7362.37419819316, 7544.547327160388, 4514.0, 4585.449746030497, 4608.400907881954, 4624.05206932578, 4630.282306242538, 2815.8873645054173, 2868.512352899991, 2895.0, 2906.869190886394, 2944.7791415643696, 876.3120950054241, 885.9468431894107, 889.4352086425102, 900.1673452056821, 913.392593925039, 9933.80132397348, 10018.549165287579, 10059.5473203706, 10064.144547713453, 10072.899271007343, 4032.9798351008058, 4097.221527909747, 4166.291730405838, 4170.7706076166105, 4184.686148538872, 8028.558429286329, 8059.63731632078, 8068.757937261891, 8070.717524886601, 8073.7577872663915, 4510.503844577094, 4518.909621807546, 4524.04994951064, 4556.134334476439, 4558.566936141061, 3603.837827297778, 4042.777647229431, 4078.0, 4120.320147175742, 4185.0, 3355.1612096975755, 3382.5433566468214, 3440.8623655053516, 3464.757466977338, 3474.8957531274104, 996.8853581838182, 999.550202408919, 1001.3491230700104, 1009.9798004039878, 1044.0864243786687, 773.6479901644739, 792.4136139256908, 797.5334429358774, 827.0571548434789, 846.8645016797283, 4709.128811169944, 4731.33761273422, 4744.857654270378, 4766.737829419346, 4873.074115917964, 849.2059923971107, 857.4598003258033, 881.8192270584515, 897.8339007283673, 906.4864249699447, 3389.57630296213, 3418.6410426905313, 3425.092350527112, 3447.844846981892, 3486.093615659947, 8686.087960764155, 8837.072107428756, 9151.17639412456, 9163.81672366549, 9169.908300917039, 9047.230985366186, 9060.637574497077, 9062.410943288665, 9068.22920051803, 9069.637214511346, 6876.140482439695, 6966.721331146698, 7012.333828286304, 7079.823004424828, 7204.0994875640545, 4815.277708343637, 4899.804007839646, 4922.335484709662, 4935.851924442272, 4972.328735620645, 8299.95850020746, 8354.122817104117, 8446.873296900674, 8481.703140390056, 8483.575821208791, 8438.915610843813, 8542.871856922275, 8599.312055035458, 8619.525926073875, 8659.0, 5172.9741351293005, 5303.337082864642, 5304.151335786256, 5962.284525856925, 6089.0, 6034.09488576717, 6600.438962688033, 6765.42493888025, 6771.62756048422, 6954.547954382949, 6014.939850601613, 6303.306636270098, 6331.398517140864, 6332.683365831598, 6523.445507131947, 6328.778492752732, 6390.233172019201, 6397.6481293529305, 6468.514861385321, 6550.181227346582, 5887.381824908323, 5892.086726557391, 5945.167676525203, 5953.91069133972, 5955.196048533393, 4161.334186530141, 4183.435236243068, 4219.07180420307, 4258.61672449481, 4300.526942036436, 4292.334688123346, 4315.741055536678, 4324.027093903846, 4407.0, 4457.7771111444945], "value": 3939.7473008686457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4071223962232, 317.363685809951, 318.5031351092296, 319.788939300062, 322.1141859885315, 4623.514530974246, 4837.685550439219, 4848.96939412867, 4862.440819305781, 4872.7563621818945, 4698.0, 4706.8352607658735, 4742.8223090529345, 4757.191277482828, 4763.309320148576, 3493.842777075025, 3598.6941110005682, 3605.1708107135373, 3678.6089042122567, 3724.571674257468, 3697.9815100924457, 3708.7033037356946, 3711.2206436648203, 3711.8329675164546, 3717.4609681596153, 3670.1191713988583, 3671.8531258749617, 3683.4843121962945, 3688.3360995020885, 3694.6305369463107, 3460.307938412315, 3565.628856810218, 3702.9444558331647, 3708.740388172829, 3712.109093817491, 3234.256121092162, 3247.8376081195847, 3259.3318369734384, 3266.2814180880405, 3288.408086544421, 4563.406757121586, 4563.498015218323, 4576.54234576543, 4577.427821522309, 4582.518835522255, 3940.2119576084897, 4186.497620285555, 4252.617264446215, 4255.212785634668, 4264.33902745075, 4943.184374578191, 4959.132151873444, 4959.16510890969, 4960.925586116211, 4984.775685094143, 3459.705924996353, 3473.4442489201606, 3477.7217822574135, 3491.4937334086417, 3494.0391392367046, 4945.085159245515, 5168.0, 5185.533302002837, 5200.089984252779, 5212.322398088262, 3611.259691763182, 3618.9276214475562, 3632.6730594246646, 3640.690541304019, 3647.8905632831056, 3684.9815750921075, 3697.6487233712755, 3709.221063576625, 3724.832382542792, 3733.4692775962267, 4151.958480415157, 4208.705390622627, 4242.66058715302, 4253.425787518708, 4262.168877069003, 4927.77824997876, 4947.727874966911, 4963.379577552806, 4975.850724478271, 4983.750812459362, 1262.551794113095, 1268.346801397281, 1272.4973635414144, 1272.5164437513686, 1274.5857596281246, 808.6280311056979, 814.1370147643516, 834.7495751274594, 860.3676297921023, 874.2394117118148, 4315.633171180422, 4331.371951067078, 4336.739795612273, 4364.650827933758, 4365.716228445141, 5049.823256186016, 5065.265536497187, 5067.746612669352, 5082.313887625123, 5087.364079490064, 4209.642180414638, 4385.671074669349, 4411.911761764747, 4424.84513042042, 4432.601065904084, 2704.9729502705113, 2729.6178535005115, 2747.766439852595, 2749.780017598587, 2773.7642300404286, 4841.540053694894, 4844.588210002189, 4860.781264843091, 4861.927071093936, 4880.536349046835, 5031.4213865405945, 5245.4788111448015, 5249.370075590953, 5292.280008997014, 5309.522143007148, 4792.904141917142, 4800.4479484859685, 4800.823798169401, 4804.591609713214, 4832.613390928787, 5108.795648174031, 5109.7700603472185, 5128.4615115413835, 5133.383993920754, 5136.30659860929, 4846.297286893451, 5063.772130254074, 5073.2897394365555, 5081.136206844919, 5086.6439349246675, 4845.0, 4849.927251091307, 4862.465128835896, 4863.294822250825, 4863.829765958175, 3656.3418584653955, 3658.5975542690817, 3691.114132608101, 3691.132583842741, 3694.519712437366, 4941.678790878582, 5141.511556402136, 5186.351706036746, 5200.6619569727845, 5204.713740744295, 4924.359833221658, 4960.379952505937, 4968.701877887338, 4979.228219625964, 4979.502049795136, 4948.727819969936, 4951.480094590016, 4951.554360107608, 4952.900941981068, 4955.851324460272, 4662.950836061859, 4910.2880082388565, 4911.537366156779, 4911.705297682151, 4918.458969513422, 4799.736014519235, 4857.2714092884935, 4975.253711943237, 4989.376327959005, 4999.300097986357, 4860.513948605111, 4863.683860549053, 4880.365552478155, 4905.043516514245, 4908.582770464551], "value": 3752.3922902948084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3229737964655, 700.9544379615321, 708.0, 709.7303024850556, 755.8412733326002, 10401.739956501091, 10501.0, 10509.0, 11966.162368634199, 12660.936695316534, 13598.18410895347, 13652.522161724342, 13675.384607692678, 13698.863011369884, 13724.65688357789, 687.336720065137, 848.8981322241309, 878.2096113497839, 884.3014018925041, 884.3986089459165, 868.891388576428, 876.132628697588, 876.1895246896627, 876.4084243135858, 876.4609764994515, 895.9104089591021, 911.731039343392, 912.4798864647154, 912.4935660708304, 912.803747194353, 724.409606170969, 882.170759486081, 910.8588168833842, 911.0115524655723, 911.8404279251138, 677.5426587053719, 678.1387637700093, 678.3420082519948, 678.5555461172939, 678.5691086160274, 10820.621278255223, 10877.07544858688, 10935.83596246057, 10939.398333091676, 10958.780824383468, 10257.43584102874, 10892.074173695246, 10929.945350273198, 11160.107191424666, 11327.603533876358, 9753.366031207948, 9920.305578609501, 9925.3548519346, 10013.799724005552, 10114.54484548197, 4077.734947228421, 4084.6323830855367, 4087.550369459357, 4100.2414553307435, 4158.064435502018, 44969.325460118125, 44996.55003449956, 45173.096538069054, 45201.0, 45412.772936135436, 9160.083991600786, 9246.7110477096, 9327.673531426502, 9368.156865882103, 9425.05749425052, 16587.419440319532, 16606.335746570243, 16610.0, 16613.0, 16629.417970370978, 6251.74993000284, 6307.905381419282, 6311.96844015777, 6402.871942561216, 6441.1626488556185, 3228.6287076985977, 3328.234506063619, 3481.4255647817827, 3602.2975519773395, 3662.633736626316, 2770.362816552204, 2867.4551835151674, 2874.568814677815, 2876.194665493665, 2880.265532289253, 409.24085820801986, 505.5273319446329, 511.4655185331338, 511.5800871176199, 516.388080125053, 525.8001959255535, 545.7707762739659, 553.8310815201322, 560.882214734902, 571.134730882713, 6198.721057552421, 6291.496680265568, 6383.872322553523, 6384.201974753156, 6412.935870641327, 468.5759387754088, 504.6064070025386, 509.98512959210905, 514.1952843799442, 556.3185098254687, 3665.321915445651, 3706.5181526401934, 3712.3688972874675, 3714.46140309659, 3821.6942644588366, 51998.48001520012, 52486.0, 55135.0, 55186.0, 55404.72297638567, 47296.344627937855, 48611.756941215775, 48793.512064878894, 49453.25820112701, 50153.49846501488, 45248.3212751809, 45500.08999819985, 45589.0, 45997.08005839864, 46423.76788116105, 6861.931380686129, 7063.223045465097, 7118.074650295428, 7257.2742725727, 7895.84208315842, 26674.33314167084, 26731.465370692866, 27675.169744907686, 27936.0, 29661.555076673434, 38655.6134438652, 39606.60393396144, 40041.59958400379, 40136.19727605373, 40216.79891600523, 10383.376997380181, 10435.895641043493, 10461.215408844519, 10625.574977000833, 10756.0, 11091.611793587186, 11139.387333696724, 11420.371879546372, 12091.0, 12331.938340308241, 10395.688129356131, 10865.0, 10922.781544368909, 11440.485178166837, 11460.426978651201, 9443.622255109718, 9549.713508594754, 9900.158486528439, 9982.60069597237, 10130.594776208869, 10382.169426446017, 10425.165986720893, 10599.735006624587, 11009.174311926477, 11190.216684831983, 9260.30547708911, 9289.674861379819, 9360.391574547633, 9375.34372593912, 9611.327207095435, 8754.08082151365, 8984.05667404913, 8988.505632190292, 9057.909420905706, 9215.124563166488], "value": 5819.191948492576, "unit": "score"}], "name": "dromaeo_css", "value": 6259.629079660427, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 114.0, 115.0, 113.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 155.0, 207.0, 131.0, 152.0, 155.0, 131.0, 194.0, 129.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 164.0, 163.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 154.0, 79.0, 75.0, 86.0, 75.0, 132.0, 75.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 93.0, 94.0, 93.0, 131.0, 93.0, 93.0, 120.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 64.0, 69.0, 64.0, 63.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 82.0, 83.0, 81.0, 84.0, 84.0, 85.0, 91.0, 173.0, 84.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 141.0, 137.0, 130.0, 139.0, 132.0, 131.0, 157.0, 141.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 175.0, 182.0, 178.0, 176.0, 184.0, 181.0, 174.0, 176.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 67.0, 70.0, 68.0, 76.0, 75.0, 67.0, 67.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1594.1000000000001, "alertThreshold": 2.0}]} 05:02:03 INFO - Return code: 0 05:02:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:02:03 ERROR - # TBPL SUCCESS # 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - ##### 05:02:03 INFO - ##### Finished run-tests step (success) 05:02:03 INFO - ##### 05:02:03 INFO - Running post-run listener: _resource_record_post_run 05:02:04 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531582976; Read time: 12; Write time: 448236 05:02:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241405952; Read time: 0; Write time: 236348 05:02:04 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290177024; Read time: 12; Write time: 211888 05:02:04 INFO - Running post-run listener: _upload_blobber_files 05:02:04 INFO - Blob upload gear active. 05:02:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:04 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 05:02:04 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:02:04 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:02:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:02:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:05 INFO - (blobuploader) - INFO - Done attempting. 05:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:06 INFO - (blobuploader) - INFO - Done attempting. 05:02:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:06 INFO - Return code: 0 05:02:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce444166d012031abfb55df69f1d22cf36c1fb67c611c28914c94a70e3f3e757945923cfe8cbc722c60fcb6e24265434b7bff1d26f1645fe3a3cd42257c115b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9632cd36d072e585c5ed99e93a652d02f50f3434065d013adf8cba04b40a290c3e5700ea450dda0a6028c59b71a5632f796b58f1c9571693fcee66a7f783ea"} 05:02:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:06 INFO - Contents: 05:02:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce444166d012031abfb55df69f1d22cf36c1fb67c611c28914c94a70e3f3e757945923cfe8cbc722c60fcb6e24265434b7bff1d26f1645fe3a3cd42257c115b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9632cd36d072e585c5ed99e93a652d02f50f3434065d013adf8cba04b40a290c3e5700ea450dda0a6028c59b71a5632f796b58f1c9571693fcee66a7f783ea"} 05:02:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:06 INFO - Copying logs to upload dir... 05:02:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.020345 ========= master_lag: 1.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-10 05:02:07.818606) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:02:07.822143) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce444166d012031abfb55df69f1d22cf36c1fb67c611c28914c94a70e3f3e757945923cfe8cbc722c60fcb6e24265434b7bff1d26f1645fe3a3cd42257c115b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9632cd36d072e585c5ed99e93a652d02f50f3434065d013adf8cba04b40a290c3e5700ea450dda0a6028c59b71a5632f796b58f1c9571693fcee66a7f783ea"} build_url:https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce444166d012031abfb55df69f1d22cf36c1fb67c611c28914c94a70e3f3e757945923cfe8cbc722c60fcb6e24265434b7bff1d26f1645fe3a3cd42257c115b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9632cd36d072e585c5ed99e93a652d02f50f3434065d013adf8cba04b40a290c3e5700ea450dda0a6028c59b71a5632f796b58f1c9571693fcee66a7f783ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:02:07.848490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:02:07.848890) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462880485.696497-263648883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003082 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:02:07.895647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:02:07.895984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:02:07.896288) ========= ========= Total master_lag: 1.39 =========