builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1462964743.99 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.993369) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.996017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.996507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.014918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.015484) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:05:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-11 04:05:44 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.199661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.200185) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.251363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.251728) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:05:44,679 truncating revision to first 12 chars 2016-05-11 04:05:44,679 Setting DEBUG logging. 2016-05-11 04:05:44,679 attempt 1/10 2016-05-11 04:05:44,679 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1dd42a351054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 04:05:45,042 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.905198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.905538) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.905955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.906223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.913389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-11 04:05:44.913767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:45 INFO - MultiFileLogger online at 20160511 04:05:45 in /builds/slave/test 04:05:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:05:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:45 INFO - {'append_to_log': False, 04:05:45 INFO - 'base_work_dir': '/builds/slave/test', 04:05:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:45 INFO - 'branch': 'Mozilla-Aurora', 04:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:45 INFO - 'config_files': ('talos/linux_config.py',), 04:05:45 INFO - 'default_actions': ('clobber', 04:05:45 INFO - 'read-buildbot-config', 04:05:45 INFO - 'download-and-extract', 04:05:45 INFO - 'populate-webroot', 04:05:45 INFO - 'create-virtualenv', 04:05:45 INFO - 'install', 04:05:45 INFO - 'run-tests'), 04:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:45 INFO - 'download_minidump_stackwalk': True, 04:05:45 INFO - 'download_symbols': 'ondemand', 04:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:45 INFO - 'installer_path': 'installer.exe', 04:05:45 INFO - 'log_level': 'info', 04:05:45 INFO - 'log_name': 'talos', 04:05:45 INFO - 'log_to_console': True, 04:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:45 INFO - 'opt_config_files': (), 04:05:45 INFO - 'pip_index': False, 04:05:45 INFO - 'sps_profile': False, 04:05:45 INFO - 'sps_profile_interval': 0, 04:05:45 INFO - 'suite': 'dromaeojs', 04:05:45 INFO - 'system_bits': '32', 04:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:45 INFO - 'title': 'talos-linux64-ix-060', 04:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:45 INFO - 'use_talos_json': True, 04:05:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:45 INFO - 'work_dir': 'build'} 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running clobber step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: clobber 04:05:45 INFO - rmtree: /builds/slave/test/build 04:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:45 INFO - Running post-action listener: _resource_record_post_action 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running read-buildbot-config step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: read_buildbot_config 04:05:45 INFO - Using buildbot properties: 04:05:45 INFO - { 04:05:45 INFO - "project": "", 04:05:45 INFO - "product": "firefox", 04:05:45 INFO - "script_repo_revision": "production", 04:05:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:05:45 INFO - "repository": "", 04:05:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:05:45 INFO - "buildid": "20160510142413", 04:05:45 INFO - "pgo_build": "True", 04:05:45 INFO - "basedir": "/builds/slave/test", 04:05:45 INFO - "buildnumber": 230, 04:05:45 INFO - "slavename": "talos-linux64-ix-060", 04:05:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:45 INFO - "platform": "ubuntu64_hw", 04:05:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:05:45 INFO - "branch": "mozilla-aurora", 04:05:45 INFO - "repo_path": "releases/mozilla-aurora", 04:05:45 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 04:05:45 INFO - "stage_platform": "linux64-pgo", 04:05:45 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 04:05:45 INFO - "slavebuilddir": "test" 04:05:45 INFO - } 04:05:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:05:45 INFO - Running post-action listener: _resource_record_post_action 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running download-and-extract step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: download_and_extract 04:05:45 INFO - mkdir: /builds/slave/test/build/tests 04:05: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:05:45 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:05:47 INFO - Downloaded 1361 bytes. 04:05:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:47 INFO - Using the following test package requirements: 04:05:47 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:47 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:47 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:05:47 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'jsshell-linux-x86_64.zip'], 04:05:47 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:47 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:47 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:05:47 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:05:47 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:47 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05: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:05:47 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:48 INFO - Downloaded 23800226 bytes. 04:05:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:49 INFO - Return code: 0 04:05:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:49 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:50 INFO - Downloaded 23800226 bytes. 04:05:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:52 INFO - Return code: 0 04:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:53 INFO - Downloaded 10840145 bytes. 04:05:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:05:53 INFO - Return code: 0 04:05: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:05:53 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:54 INFO - Downloaded 62686755 bytes. 04:05:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:54 INFO - mkdir: /builds/slave/test/properties 04:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:54 INFO - Contents: 04:05:54 INFO - build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:55 INFO - Running post-action listener: _resource_record_post_action 04:05:55 INFO - Running post-action listener: set_extra_try_arguments 04:05:55 INFO - ##### 04:05:55 INFO - ##### Running populate-webroot step. 04:05:55 INFO - ##### 04:05:55 INFO - Running pre-action listener: _resource_record_pre_action 04:05:55 INFO - Running main action method: populate_webroot 04:05:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:55 INFO - '--tppagecycles', 04:05:55 INFO - '7'], 04:05:55 INFO - 'tests': ['tsvgm']}}, 04:05:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['damp', 'tps']}, 04:05:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['damp', 'tps']}, 04:05:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['dromaeo_dom']}, 04:05:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tsvgx', 04:05:55 INFO - 'tsvgr_opacity', 04:05:55 INFO - 'tart', 04:05:55 INFO - 'tscrollx', 04:05:55 INFO - 'cart']}, 04:05:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:55 INFO - 'tsvgr_opacity', 04:05:55 INFO - 'tart', 04:05:55 INFO - 'tscrollx', 04:05:55 INFO - 'cart']}, 04:05:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tp5o']}, 04:05:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['tp5o']}, 04:05:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s', 04:05:55 INFO - '--xperf_path', 04:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:55 INFO - 'tests': ['tp5n']}, 04:05:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--xperf_path', 04:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:55 INFO - 'tests': ['tp5n']}}, 04:05:55 INFO - 'talos.zip': {'path': '', 04:05:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:55 INFO - Running post-action listener: _resource_record_post_action 04:05:55 INFO - ##### 04:05:55 INFO - ##### Running create-virtualenv step. 04:05:55 INFO - ##### 04:05:55 INFO - Running pre-action listener: _resource_record_pre_action 04:05:55 INFO - Running main action method: create_virtualenv 04:05:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:55 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:05:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:55 INFO - Using real prefix '/usr' 04:05:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:58 INFO - Installing pip.................done. 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:58 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:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:05:58 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:05:58 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:05:58 INFO - Using env: {'DISPLAY': ':0', 04:05:58 INFO - 'HOME': '/home/cltbld', 04:05:58 INFO - 'LANG': 'en_US.UTF-8', 04:05:58 INFO - 'LANGUAGE': 'en_US:en', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MAIL': '/var/mail/cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SHLVL': '1', 04:05:58 INFO - 'TERM': 'linux', 04:05:58 INFO - 'TMOUT': '86400', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 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:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05:58 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:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:05:58 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:05:58 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:05:58 INFO - Using env: {'DISPLAY': ':0', 04:05:58 INFO - 'HOME': '/home/cltbld', 04:05:58 INFO - 'LANG': 'en_US.UTF-8', 04:05:58 INFO - 'LANGUAGE': 'en_US:en', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MAIL': '/var/mail/cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SHLVL': '1', 04:05:58 INFO - 'TERM': 'linux', 04:05:58 INFO - 'TMOUT': '86400', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 INFO - Downloading/unpacking psutil>=0.7.1 04:05: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:05: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:05: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:05: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:05: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:05: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:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:00 INFO - Installing collected packages: psutil 04:06:00 INFO - Running setup.py install for psutil 04:06:00 INFO - building 'psutil._psutil_linux' extension 04:06:00 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:06:00 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:06:00 INFO - building 'psutil._psutil_posix' extension 04:06:00 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:06:00 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:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:00 INFO - Successfully installed psutil 04:06:00 INFO - Cleaning up... 04:06:00 INFO - Return code: 0 04:06:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06: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:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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', '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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:06: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 mozsystemmonitor==0.0.0 04:06:00 INFO - Using env: {'DISPLAY': ':0', 04:06:00 INFO - 'HOME': '/home/cltbld', 04:06:00 INFO - 'LANG': 'en_US.UTF-8', 04:06:00 INFO - 'LANGUAGE': 'en_US:en', 04:06:00 INFO - 'LOGNAME': 'cltbld', 04:06:00 INFO - 'MAIL': '/var/mail/cltbld', 04:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:00 INFO - 'MOZ_NO_REMOTE': '1', 04:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:00 INFO - 'NO_EM_RESTART': '1', 04:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:00 INFO - 'PWD': '/builds/slave/test', 04:06:00 INFO - 'SHELL': '/bin/bash', 04:06:00 INFO - 'SHLVL': '1', 04:06:00 INFO - 'TERM': 'linux', 04:06:00 INFO - 'TMOUT': '86400', 04:06:00 INFO - 'USER': 'cltbld', 04:06:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:00 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:03 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:06:03 INFO - Installing collected packages: mozsystemmonitor 04:06:03 INFO - Running setup.py install for mozsystemmonitor 04:06:03 INFO - Successfully installed mozsystemmonitor 04:06:03 INFO - Cleaning up... 04:06:03 INFO - Return code: 0 04:06:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:03 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:03 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:06:03 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:06:03 INFO - Using env: {'DISPLAY': ':0', 04:06:03 INFO - 'HOME': '/home/cltbld', 04:06:03 INFO - 'LANG': 'en_US.UTF-8', 04:06:03 INFO - 'LANGUAGE': 'en_US:en', 04:06:03 INFO - 'LOGNAME': 'cltbld', 04:06:03 INFO - 'MAIL': '/var/mail/cltbld', 04:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:03 INFO - 'MOZ_NO_REMOTE': '1', 04:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:03 INFO - 'NO_EM_RESTART': '1', 04:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:03 INFO - 'PWD': '/builds/slave/test', 04:06:03 INFO - 'SHELL': '/bin/bash', 04:06:03 INFO - 'SHLVL': '1', 04:06:03 INFO - 'TERM': 'linux', 04:06:03 INFO - 'TMOUT': '86400', 04:06:03 INFO - 'USER': 'cltbld', 04:06:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:03 INFO - '_': '/tools/buildbot/bin/python'} 04:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:06: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:06: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:06: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:06: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:06: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:06: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:06:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:06 INFO - Downloading docopt-0.6.1.tar.gz 04:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:06 INFO - Running setup.py install for blobuploader 04:06:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:06 INFO - Running setup.py install for requests 04:06:06 INFO - Running setup.py install for docopt 04:06:06 INFO - Successfully installed blobuploader requests docopt 04:06:06 INFO - Cleaning up... 04:06:06 INFO - Return code: 0 04:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:06 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:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 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:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:06 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:06 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:06:06 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:06:06 INFO - Using env: {'DISPLAY': ':0', 04:06:06 INFO - 'HOME': '/home/cltbld', 04:06:06 INFO - 'LANG': 'en_US.UTF-8', 04:06:06 INFO - 'LANGUAGE': 'en_US:en', 04:06:06 INFO - 'LOGNAME': 'cltbld', 04:06:06 INFO - 'MAIL': '/var/mail/cltbld', 04:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:06 INFO - 'MOZ_NO_REMOTE': '1', 04:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:06 INFO - 'NO_EM_RESTART': '1', 04:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:06 INFO - 'PWD': '/builds/slave/test', 04:06:06 INFO - 'SHELL': '/bin/bash', 04:06:06 INFO - 'SHLVL': '1', 04:06:06 INFO - 'TERM': 'linux', 04:06:06 INFO - 'TMOUT': '86400', 04:06:06 INFO - 'USER': 'cltbld', 04:06:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:06 INFO - '_': '/tools/buildbot/bin/python'} 04:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:06 INFO - Running setup.py (path:/tmp/pip-7BPQTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:07 INFO - Running setup.py (path:/tmp/pip-o_VmAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:07 INFO - Running setup.py (path:/tmp/pip-zIK0K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:07 INFO - Running setup.py (path:/tmp/pip-RHqOAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:07 INFO - Running setup.py (path:/tmp/pip-ExGR2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:07 INFO - Running setup.py (path:/tmp/pip-XwQe2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:07 INFO - Running setup.py (path:/tmp/pip-vgmyDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:07 INFO - Running setup.py (path:/tmp/pip-UIZsjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:07 INFO - Running setup.py (path:/tmp/pip-p3ZgB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:07 INFO - Running setup.py (path:/tmp/pip-YIxxBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:07 INFO - Running setup.py (path:/tmp/pip-8iTh6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:07 INFO - Running setup.py (path:/tmp/pip-XOQknr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:07 INFO - Running setup.py (path:/tmp/pip-zsCqD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:07 INFO - Running setup.py (path:/tmp/pip-YPtGnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:07 INFO - Running setup.py (path:/tmp/pip-yNjMYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:08 INFO - Running setup.py (path:/tmp/pip-3fG_8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:08 INFO - Running setup.py (path:/tmp/pip-WVMp05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:08 INFO - Running setup.py install for manifestparser 04:06:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozcrash 04:06:08 INFO - Running setup.py install for mozdebug 04:06:08 INFO - Running setup.py install for mozdevice 04:06:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozfile 04:06:08 INFO - Running setup.py install for mozhttpd 04:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozinfo 04:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozInstall 04:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozleak 04:06:09 INFO - Running setup.py install for mozlog 04:06:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for moznetwork 04:06:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for mozprocess 04:06:09 INFO - Running setup.py install for mozprofile 04:06:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for mozrunner 04:06:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for mozscreenshot 04:06:09 INFO - Running setup.py install for moztest 04:06:09 INFO - Running setup.py install for mozversion 04:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:09 INFO - Cleaning up... 04:06:09 INFO - Return code: 0 04:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:09 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:09 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:06:09 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:06:09 INFO - Using env: {'DISPLAY': ':0', 04:06:09 INFO - 'HOME': '/home/cltbld', 04:06:09 INFO - 'LANG': 'en_US.UTF-8', 04:06:09 INFO - 'LANGUAGE': 'en_US:en', 04:06:09 INFO - 'LOGNAME': 'cltbld', 04:06:09 INFO - 'MAIL': '/var/mail/cltbld', 04:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:09 INFO - 'MOZ_NO_REMOTE': '1', 04:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:09 INFO - 'NO_EM_RESTART': '1', 04:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:09 INFO - 'PWD': '/builds/slave/test', 04:06:09 INFO - 'SHELL': '/bin/bash', 04:06:09 INFO - 'SHLVL': '1', 04:06:09 INFO - 'TERM': 'linux', 04:06:09 INFO - 'TMOUT': '86400', 04:06:09 INFO - 'USER': 'cltbld', 04:06:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:09 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:10 INFO - Running setup.py (path:/tmp/pip-5AOibZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:10 INFO - Running setup.py (path:/tmp/pip-_gx3bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:10 INFO - Running setup.py (path:/tmp/pip-YhaJDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:10 INFO - Running setup.py (path:/tmp/pip-fII8E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:10 INFO - Running setup.py (path:/tmp/pip-NLECsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:10 INFO - Running setup.py (path:/tmp/pip-vje8xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:10 INFO - Running setup.py (path:/tmp/pip-3nUhuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:10 INFO - Running setup.py (path:/tmp/pip-wgkQ9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:10 INFO - Running setup.py (path:/tmp/pip-QkcexX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:10 INFO - Running setup.py (path:/tmp/pip-uWwaA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:10 INFO - Running setup.py (path:/tmp/pip-nvlGNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:10 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:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:10 INFO - Running setup.py (path:/tmp/pip-ZcRNYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:11 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:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:11 INFO - Running setup.py (path:/tmp/pip-YxfR5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:11 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:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:11 INFO - Running setup.py (path:/tmp/pip-YObZOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:11 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:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:11 INFO - Running setup.py (path:/tmp/pip-6tugBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:11 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:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:11 INFO - Running setup.py (path:/tmp/pip-t6c4xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:11 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:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:11 INFO - Running setup.py (path:/tmp/pip-ZvH1Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:11 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:06:11 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:06:11 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:06:11 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:06:11 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:06:11 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:06:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:13 INFO - Downloading blessings-1.6.tar.gz 04:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:13 INFO - Installing collected packages: blessings 04:06:13 INFO - Running setup.py install for blessings 04:06:13 INFO - Successfully installed blessings 04:06:13 INFO - Cleaning up... 04:06:13 INFO - Return code: 0 04:06:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:13 INFO - Reading from file tmpfile_stdout 04:06:13 INFO - Current package versions: 04:06:13 INFO - argparse == 1.2.1 04:06:13 INFO - blessings == 1.6 04:06:13 INFO - blobuploader == 1.2.4 04:06:13 INFO - docopt == 0.6.1 04:06:13 INFO - manifestparser == 1.1 04:06:13 INFO - mozInstall == 1.12 04:06:13 INFO - mozcrash == 0.17 04:06:13 INFO - mozdebug == 0.1 04:06:13 INFO - mozdevice == 0.48 04:06:13 INFO - mozfile == 1.2 04:06:13 INFO - mozhttpd == 0.7 04:06:13 INFO - mozinfo == 0.9 04:06:13 INFO - mozleak == 0.1 04:06:13 INFO - mozlog == 3.1 04:06:13 INFO - moznetwork == 0.27 04:06:13 INFO - mozprocess == 0.22 04:06:13 INFO - mozprofile == 0.28 04:06:13 INFO - mozrunner == 6.11 04:06:13 INFO - mozscreenshot == 0.1 04:06:13 INFO - mozsystemmonitor == 0.0 04:06:13 INFO - moztest == 0.7 04:06:13 INFO - mozversion == 1.4 04:06:13 INFO - psutil == 3.1.1 04:06:13 INFO - requests == 1.2.3 04:06:13 INFO - wsgiref == 0.1.2 04:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:13 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:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 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:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 04:06:13 INFO - 'HOME': '/home/cltbld', 04:06:13 INFO - 'LANG': 'en_US.UTF-8', 04:06:13 INFO - 'LANGUAGE': 'en_US:en', 04:06:13 INFO - 'LOGNAME': 'cltbld', 04:06:13 INFO - 'MAIL': '/var/mail/cltbld', 04:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:13 INFO - 'MOZ_NO_REMOTE': '1', 04:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:13 INFO - 'NO_EM_RESTART': '1', 04:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:13 INFO - 'PWD': '/builds/slave/test', 04:06:13 INFO - 'SHELL': '/bin/bash', 04:06:13 INFO - 'SHLVL': '1', 04:06:13 INFO - 'TERM': 'linux', 04:06:13 INFO - 'TMOUT': '86400', 04:06:13 INFO - 'USER': 'cltbld', 04:06:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:13 INFO - '_': '/tools/buildbot/bin/python'} 04:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 INFO - Cleaning up... 04:06:13 INFO - Return code: 0 04:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:13 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:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 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:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:13 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 04:06:13 INFO - 'HOME': '/home/cltbld', 04:06:13 INFO - 'LANG': 'en_US.UTF-8', 04:06:13 INFO - 'LANGUAGE': 'en_US:en', 04:06:13 INFO - 'LOGNAME': 'cltbld', 04:06:13 INFO - 'MAIL': '/var/mail/cltbld', 04:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:13 INFO - 'MOZ_NO_REMOTE': '1', 04:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:13 INFO - 'NO_EM_RESTART': '1', 04:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:13 INFO - 'PWD': '/builds/slave/test', 04:06:13 INFO - 'SHELL': '/bin/bash', 04:06:13 INFO - 'SHLVL': '1', 04:06:13 INFO - 'TERM': 'linux', 04:06:13 INFO - 'TMOUT': '86400', 04:06:13 INFO - 'USER': 'cltbld', 04:06:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:13 INFO - '_': '/tools/buildbot/bin/python'} 04:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:14 INFO - Downloading/unpacking jsonschema 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:16 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:16 INFO - warning: no files found matching '*.txt' 04:06:16 INFO - no previously-included directories found matching 'build' 04:06:16 INFO - no previously-included directories found matching 'dist' 04:06:16 INFO - no previously-included directories found matching '.git*' 04:06:16 INFO - Installing collected packages: jsonschema, functools32 04:06:16 INFO - Running setup.py install for functools32 04:06:16 INFO - warning: no files found matching '*.txt' 04:06:16 INFO - no previously-included directories found matching 'build' 04:06:16 INFO - no previously-included directories found matching 'dist' 04:06:16 INFO - no previously-included directories found matching '.git*' 04:06:16 INFO - Successfully installed jsonschema functools32 04:06:16 INFO - Cleaning up... 04:06:16 INFO - Return code: 0 04:06:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:16 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 0x7ffd8356ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28695a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 04:06:16 INFO - 'HOME': '/home/cltbld', 04:06:16 INFO - 'LANG': 'en_US.UTF-8', 04:06:16 INFO - 'LANGUAGE': 'en_US:en', 04:06:16 INFO - 'LOGNAME': 'cltbld', 04:06:16 INFO - 'MAIL': '/var/mail/cltbld', 04:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:16 INFO - 'MOZ_NO_REMOTE': '1', 04:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:16 INFO - 'NO_EM_RESTART': '1', 04:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:16 INFO - 'PWD': '/builds/slave/test', 04:06:16 INFO - 'SHELL': '/bin/bash', 04:06:16 INFO - 'SHLVL': '1', 04:06:16 INFO - 'TERM': 'linux', 04:06:16 INFO - 'TMOUT': '86400', 04:06:16 INFO - 'USER': 'cltbld', 04:06:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:16 INFO - '_': '/tools/buildbot/bin/python'} 04:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:16 INFO - Downloading/unpacking flake8 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:19 INFO - no previously-included directories found matching 'docs/_build' 04:06:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:19 INFO - Running setup.py install for pep8 04:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:19 INFO - no previously-included directories found matching 'docs/_build' 04:06:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:19 INFO - Cleaning up... 04:06:19 INFO - Return code: 0 04:06:19 INFO - Running post-action listener: _resource_record_post_action 04:06:19 INFO - Running post-action listener: _start_resource_monitoring 04:06:19 INFO - Starting resource monitoring. 04:06:19 INFO - ##### 04:06:19 INFO - ##### Running install step. 04:06:19 INFO - ##### 04:06:19 INFO - Running pre-action listener: _resource_record_pre_action 04:06:19 INFO - Running main action method: install 04:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:19 INFO - Reading from file tmpfile_stdout 04:06:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:19 INFO - Reading from file tmpfile_stdout 04:06:19 INFO - Output received: 04:06:19 INFO - Usage: mozinstall [options] installer 04:06:19 INFO - Options: 04:06:19 INFO - -h, --help show this help message and exit 04:06:19 INFO - -d DEST, --destination=DEST 04:06:19 INFO - Directory to install application into. [default: 04:06:19 INFO - "/builds/slave/test"] 04:06:19 INFO - --app=APP Application being installed. [default: firefox] 04:06:19 INFO - mkdir: /builds/slave/test/build/application 04:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:06:35 INFO - Reading from file tmpfile_stdout 04:06:35 INFO - Output received: 04:06:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:35 INFO - Running post-action listener: _resource_record_post_action 04:06:35 INFO - ##### 04:06:35 INFO - ##### Running run-tests step. 04:06:35 INFO - ##### 04:06:35 INFO - Running pre-action listener: _resource_record_pre_action 04:06:35 INFO - Running main action method: run_tests 04:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:35 INFO - Python 2.7.3 04:06:35 INFO - Return code: 0 04:06:35 INFO - grabbing minidump binary from tooltool 04:06: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:06:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x28f8410>, '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 0x28f9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:06:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:35 INFO - Return code: 0 04:06:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:36 INFO - Return code: 0 04:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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:06:36 INFO - Using env: {'DISPLAY': ':0', 04:06:36 INFO - 'HOME': '/home/cltbld', 04:06:36 INFO - 'LANG': 'en_US.UTF-8', 04:06:36 INFO - 'LANGUAGE': 'en_US:en', 04:06:36 INFO - 'LOGNAME': 'cltbld', 04:06:36 INFO - 'MAIL': '/var/mail/cltbld', 04:06:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:36 INFO - 'MOZ_NO_REMOTE': '1', 04:06:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:36 INFO - 'NO_EM_RESTART': '1', 04:06:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:36 INFO - 'PWD': '/builds/slave/test', 04:06:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:36 INFO - 'SHELL': '/bin/bash', 04:06:36 INFO - 'SHLVL': '1', 04:06:36 INFO - 'TERM': 'linux', 04:06:36 INFO - 'TMOUT': '86400', 04:06:36 INFO - 'USER': 'cltbld', 04:06:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257', 04:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:36 INFO - '_': '/tools/buildbot/bin/python'} 04:06:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:06:36 INFO - mozversion application_buildid: 20160510142413 04:06:36 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:06:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:36 INFO - mozversion application_name: Firefox 04:06:36 INFO - mozversion application_remotingname: firefox-dev 04:06:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:36 INFO - mozversion application_vendor: Mozilla 04:06:36 INFO - mozversion application_version: 48.0a2 04:06:36 INFO - mozversion platform_buildid: 20160510142413 04:06:36 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:36 INFO - mozversion platform_version: 48.0a2 04:06:36 INFO - using testdate: 1462964796 04:06:36 INFO - actual date: 1462964796 04:06:36 INFO - starting webserver on 'localhost:49153' 04:06:36 INFO - SUITE-START | Running 2 tests 04:06:36 INFO - TEST-START | dromaeo_css 04:06:36 INFO - operating with platform_type : linux_ 04:06:36 INFO - Initialising browser for dromaeo_css test... 04:06:36 INFO - TEST-INFO | started process 17652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0T3KE/profile http://localhost:49153/getInfo.html) 04:06:40 INFO - PROCESS | 17652 | __metrics Screen width/height:1600/1200 04:06:40 INFO - PROCESS | 17652 | colorDepth:24 04:06:40 INFO - PROCESS | 17652 | Browser inner width/height: 1024/697 04:06:40 INFO - PROCESS | 17652 | __metrics 04:06:42 ERROR - PROCESS | 17652 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:06:42 INFO - TEST-INFO | 17652: exit 0 04:06:42 INFO - Browser initialized. 04:06:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:42 INFO - TEST-INFO | started process 17742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr0T3KE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:54 INFO - PROCESS | 17742 | RSS: Main: 141348864 04:06:54 INFO - PROCESS | 17742 | 04:07:46 INFO - PROCESS | 17742 | 1462964866179 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:09:53 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49153/tests/dromaeo/cssquery-ext.html) 04:09:54 INFO - PROCESS | 17742 | RSS: Main: 242216960 04:09:54 INFO - PROCESS | 17742 | 04:12:56 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-ext.html (next: http://localhost:49153/tests/dromaeo/cssquery-jquery.html) 04:12:57 INFO - PROCESS | 17742 | RSS: Main: 227581952 04:12:57 INFO - PROCESS | 17742 | 04:15:58 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49153/tests/dromaeo/cssquery-mootools.html) 04:15:59 INFO - PROCESS | 17742 | RSS: Main: 222916608 04:15:59 INFO - PROCESS | 17742 | 04:19:01 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49153/tests/dromaeo/cssquery-prototype.html) 04:19:01 INFO - PROCESS | 17742 | RSS: Main: 218337280 04:19:01 INFO - PROCESS | 17742 | 04:22:04 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49153/tests/dromaeo/cssquery-yui.html) 04:22:04 INFO - PROCESS | 17742 | RSS: Main: 183914496 04:22:04 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | Cycle 1(1): loaded http://localhost:49153/tests/dromaeo/cssquery-yui.html (next: http://localhost:49153/tests/dromaeo/cssquery-dojo.html) 04:25:07 INFO - PROCESS | 17742 | RSS: Main: 268300288 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | __start_tp_report 04:25:07 INFO - PROCESS | 17742 | _x_x_mozilla_page_load 04:25:07 INFO - PROCESS | 17742 | _x_x_mozilla_page_load_details 04:25:07 INFO - PROCESS | 17742 | |i|pagename|runs| 04:25:07 INFO - PROCESS | 17742 | |0;dojo.html;3296.8351582420883;3357.278185190185;3365.5961284645814;3374.52756614074;3403.8468268927913;5560.082586373249;5568.888622227558;5593.804216852411;5602.691851948151;5629.746661400237;5594.608377413582;5605.971970140154;5624.15637654352;5628.380878103405;5636.182902584493;5042.621803364744;5095.923561146586;5098.745062746875;5159.509846564571;5214.270002199695;5047.394312682483;5075.137226671474;5088.669236499634;5095.566876815476;5138.486151384869;5021.1213037718435;5086.135356989321;5089.949100508985;5092.516210959953;5095.133827249377;5056.696598204083;5131.204663277198;5131.794728210867;5139.640225184257;5144.279800827869;4879.146149423872;4968.180250258703;5030.622703297231;5043.067032598981;5050.39395272566;5401.4868587484125;5415.675059496403;5416.972915135439;5418.431064738224;5436.592255580847;5853.268341457318;5884.764609415618;5888.941110588882;5889.234399528077;5894.056950887837;5789.421057894219;5921.792737254218;5955.047192449188;5977.252843394575;5982.670953097621;5514.6691198527815;5547.611667183299;5551.861203469905;5554.1391084381985;5555.777768889239;5989.490893274121;6018.398160183947;6067.848303792441;6069.514438844882;6077.6961151943115;5820.214271073351;5890.293164820249;5921.023031199804;5922.940770592325;5926.970365148147;5924.052151655715;5936.821895343147;5938;5942.910856337158;5947.316058653224;5792.565557583114;5906.911396329058;5908.556858235649;5916.2013128228;5920.674362910081;5824.708764561755;5899.203607513016;5940.405959404112;5946.85132871673;5957.076653118774;4456.68803183774;4478.664100192498;4485.304777759453;4486.730796152176;4511.796969136397;3949.1114499238015;4016.779077150726;4022.7184097113504;4029.0531725044593;4035.8385664573675;5542.806001789918;5666.320041595035;5667.631603945731;5672.744726487318;5699.82900512977;5990.7004649768205;6016.368281330485;6020.638761674313;6023.45788879003;6025.849353766191;5449.509544141047;5649.604527683023;5674.546036317085;5704.600677952503;5707.286589176353;4825.831095911626;4829.830955916596;4832.323474713543;4837.419509658864;4860.538248866352;6117.265928088658;6169.537284703575;6176.907346389808;6178.62928224308;6179.567430279837;5841.795537156349;5964.31410387811;5974.4622983930785;5984.1323008164445;6006.459418652343;6082.817515474543;6087.66517841523;6089.2997305310455;6090.269167699905;6118.816435506942;5776;5788.971055144697;5794.333651629948;5795.797147099831;5801.129830525286;5730.713464326684;5891.528677705687;5897.764089436375;5910.793122240873;5967.880642387215;5658.801941932013;5706.400827913009;5755.223044888887;5757.424257574209;5798.82603521895;5707.771689132388;5709.628874123168;5712.485876270989;5717.42825717425;5740.425957404226;5593.272874526286;5620.522255608319;5699.629524080921;5763.6541807491685;5773.307203135482;5826.067829147316;5829.329627092939;5837.912431313449;5846.824595262149;5859.794907178229;5704.286964129484;5705.971470142623;5709.029464990878;5712.200291959212;5723.942760572341 04:25:07 INFO - PROCESS | 17742 | |1;ext.html;665.9001149827528;667.2326824152227;671.348791672078;727.2436665867498;738.8337624034591;31360.372792544134;31859.203519911985;32095.19762005951;38998.610013899925;39360;42180;42750.14499710004;42787;42840.78579607105;42856.14287714244;8750.518721470333;9015;9015.639374425014;9016.59425325862;9021.548922553879;8198;8657.567121643924;10635.627753028646;10888;10893.128549716004;10609.204309676805;10702.30435021725;10704.875988021262;10705.518251678694;10707.946460267687;10462.267641265114;10541.26211165215;10541.31481453703;10554.102901253402;10558.049775520163;10275.48622568876;10336.586536538529;10342.37945723259;10359.22305827066;10366;39428.8171354857;43584.56415435868;43744.562554374366;43835.561644383466;43836;3752.9437058444146;3792.2984247914223;3841.4621952926614;3872.9806350968347;4081.3673880548267;32950.50574241388;33307.16732081693;33642;34707.30585388303;35446.64553354485;4631.235846085392;4724.149653062447;4737.881552961204;4758.357621721093;4817.470078291421;326783;328071.3596432026;328296;328484;328578;39313.606863930996;59889;60025;60359.69820150959;60439;37479.81260093682;37640.81179594085;37731.245375092345;37742.8112859434;37746;16847.83152168487;17022.404215852384;17041;17056.57358566046;17058.65882682364;12566.748665026647;13592.728145437035;13900.096493727875;14530.491432799801;14603.488877889435;8938.46369217849;8998.190162885372;9025.774355641162;9071.818563628822;9090.954545227232;3547.5565554305713;3572.821358932043;3582.8387722552548;3588.5873124590485;3635.9818200909353;1086.0768346905224;1115.4924509348227;1130.5421304371744;1205.6322821539516;1253.95611153611;31344;31438.37123257522;31528.842355788074;31826;32577.348453030805;1202.4949521201117;1231.9322437266037;1243.975120497585;1273.5160638957136;1344.683999260173;17309.91345043267;17626.64746705059;17658.823411765974;17712;17784.644307113784;454011;455022;455638;456134;458650;61848.690756545926;62568;63086.68456657687;63093;63143;1387.6877702516854;1394.741972735027;1466.30350583472;1530.556138719781;1540.8459154084726;33555.328893422484;37221.1752270984;37251.25497490089;37519.24961500809;37576.62423375731;57212.14181787193;57907.420925790204;58077;58426.4157358421;58664.413355867604;436828;442767;443763;447523;447913;39200;45634;46190.76904615456;46783;47024.7648761754;44192.55807442013;44644.33033504435;44771.32843007422;45217.773911130236;45672.31491527696;37709.622903771706;37996;38810;39773;41798.791006044776;40556.59443405528;40941.59058409378;41366.37950430806;41719.58280417157;42332.788336058125;41927.37108943307;42193.78903105465;42971.57028429801;43247.35128973005;43503.34744978891;34823.4776478348;36367.818160909024;36743.81628091842;36896;37467.25065498729;28675.28311792222;28999;29063.418731624824;29065.418691626473;29106 04:25:07 INFO - PROCESS | 17742 | |2;jquery.html;421.9620234178924;424.40583183543043;434.2379124636263;435.79735423028285;438.0691031557939;18570.814291857077;19136.90431547842;19338.419847404584;19440.805591944078;20340.186392544318;12546.937265313683;12847.164934279288;13569.932150339235;19871;19872.30446934354;5234.42421333654;5393.6763794172475;5398.649087809299;5427.294451721291;5547.694876781776;5730.341010783751;5832.854178645525;5838.562107841907;5867.2372591563035;5873.853153671171;5492.450754924495;5801.535877129841;5837.1536127261525;5844.853878653046;5846.532277417797;5354.437784032699;5384.084705600018;5391.703456309901;5395.001924643934;5399.379071406799;5163.32876726027;5196.948030519722;5203.375594928595;5203.427622961509;5205.739713014372;13389.799153012713;13852.238126903016;13918.164910105324;13925.79111313321;13940.442382304696;2466.9753302466925;2538.7334329895466;2568.460623269116;2910.941781164386;3061.5713800068006;10179.796404071878;10213.846792298122;10344.844827327595;10574.841377379345;10943.343399395982;1948.856258116061;1973.8716983396178;2100.4013856051106;2119.6078725435846;2131.211451762842;79255.60372198102;79844.60077699632;79859.99999999942;81545.59227203885;81904.59047704723;11111.777764444665;11272.492737826817;11939.283642981449;11995.100367472474;12016.218945768496;16720.411560901695;16822.747658785127;17076.146192690318;17082.487525374258;17108.230129644195;9177.449353038839;9180.531115021698;9247.213986811063;9259.212966897754;9271.165595096474;9057.049009854003;9075.909240907506;9106;9187.63249470027;9243.26053915685;5093.388793344822;5108.948910510921;5124;5148;5160.40655324635;2050.9487262818548;2076.449740818654;2086.35323049855;2109.963884851126;2113.3554265949033;1006.9949650251848;1084.6095405653957;1120.6806060272784;1128.4019469680918;1134.7673726885969;18734.156962936428;19237;19704.802951970298;19783.20867165326;20061;1056.1603525197334;1060.9363438193734;1064.6000509330206;1075.1130317488103;1082.4209048159355;8116.35069194463;11073.335599864035;11178.496967636476;11368.658940231806;11384.487698053608;557251;562646;570748;579714;582212;81586.18413815786;95274;95283;95768;97195.51402243086;1082.6210826210763;1115.704338350354;1122.4948773052158;1129.824877144044;1137.4881303413497;17101.401450949157;17224.483265502055;17250.396236131674;17327.740083899003;17473.038982856066;40319.99200020023;40943.18113637651;41088.38367424551;42014.78992605017;42745.35881961711;57663;58496.70751646214;58594.7070264663;58622;58944.705276473345;8604.225619694258;9175.08249175077;9191.77020574491;9199.816003680024;9772.56023478931;11776.52893884235;13738.450461981409;13880.791788123388;13966.371513281723;14113.647158821112;12307.75384492323;12495.312757798409;12641.494340226289;12690.175138615961;12853.871461285267;12079.456424460745;12139.878601214228;12359.32023738703;12435.37823108859;12458.937705311415;11913.880861191625;12001.63995080149;12009.579664711693;12463.501459941863;12512.249265044127;8474.491530508189;8784.472931624123;8965.596548155218;9121.817563648823;9171.770705732144;11280.49237784318;11652.184347095623;12241.764377442869;12257.14200005991;12396.81404778911 04:25:07 INFO - PROCESS | 17742 | |3;mootools.html;1401.117296103456;1543.058734172155;1544.7065057639047;1757.481542944831;1860.9906950465254;7826.413019023575;8056.436049476539;8058;8075.596220188996;8081.595920203996;7876.606169691507;8061.516309021463;8062.838743225132;8066.3546916246705;8084.393670474723;2026.71625972364;2066.0392917293457;2066.803653652908;2277.089164334267;2318.3392733071078;2216.036024329414;2264.784845439689;2269.024319542596;2275.977240227593;2277.191596983072;2240.9887950560224;2284;2295.1393227539675;2295.6326987681973;2317.397476656073;2014.0735261779598;2055.3320170944503;2308.988455057722;2328.673985642003;2331.8834058297102;1972.437855211258;2204.5260269042233;2266.841321107523;2266.9319920402413;2268.5009297954425;7932.2067793220795;7935.087464941548;7940.682372705142;7953.642086106139;7956.085050219183;5010.073136469765;5093.821716239951;5122.769475373617;5131.923021154686;5139;3357.9832100839585;3411.4371128763723;3448.0345503259127;3456.827158642058;3476.3394954958476;1224.8897599216025;1244.1850587864872;1259;1281.88463038327;1353.1407556201784;11629.592964246296;11665.066794656406;11670.76658466826;11687.766244675144;11690.240134391237;4464.263396539534;4539.0694907543875;4581.244094724333;4585.335126406652;4644.767761611906;9875.555599998017;9886.604535818631;9892.65375711861;9913.157381622499;9918.454485003249;5163.509466600667;5169.53474187325;5193.974030129901;5206;5207.531322181022;4239.872803815891;4504.842330518416;4632.305154226826;4793.616510679138;4813.15769740294;3936.566977632458;3993.7603743775467;4065.3901914712437;4097.672186225095;4129.339305711072;1286.6397408725572;1304.1327517200955;1307.1438207973792;1315.5921664284103;1328.3225554967037;1064.8189807732704;1076.079951641351;1079.6868908016588;1080.4165750494801;1085.2891356161726;5807.390224026416;5873.089671100986;5922.970385148046;5954.76180952757;6008.309044459856;482.6404328775085;484.71159660002945;491.0694234425743;491.91391506486224;501.00050399453323;4122.072533679958;4138.730982486129;4145.357469592218;4197.433346498184;4198.958010419918;9655.662051828152;9841.163501102343;9899.455529945923;10261.846072308921;10329.173666106693;9634.759131021781;9722.708318750449;9882.160016398542;9905.851412228822;9910.702678919644;7428.182899881009;7572.4699271050495;7639.770806875803;8115.188481151956;8183.099859015503;5983.431574000463;5999.370066143167;6070.332263451105;6077.453029227391;6132.601380910227;9116.225120864536;9118.863217051618;9202.079792020744;9252.768680783034;9400.388974716621;9123.406978546373;9290.95354523223;9302.674406395743;9336;9519.38124021964;6671.46628269747;7030.261822508563;7198.100237470317;7488.251174882686;7586.582737949466;7962.601869906597;7987.720429784929;8026.237507436784;8061.758147255592;8068.919310806817;6874.381305682513;7279.272072792678;7349.6325183741665;7353.852922941618;7482.438817088849;7184.6048467334795;7197.604131772803;7203.123530896407;7242.818929526804;7321.158066822383;6820.658967051727;6835.350641689031;6913.758018469531;6919.273476284918;6924.065251191226;5006.224035274538;5073.2897394365555;5074.974625126851;5088.211327244283;5089.643724939218;5235.63350565472;5295;5306.310179676618;5315.867103322448;5423.701696406578 04:25:07 INFO - PROCESS | 17742 | |4;prototype.html;336.24345223247695;351.2868876181351;358.72019824536864;368.35905524387573;369.7596562234549;6314.684265786709;6319;6354.777582784598;6384.744610215585;6389.488840892717;6010.8797824043495;6152.600080994744;6308.337624549425;6314.084457753623;6338.714757835897;4834.4923783002805;4857.6599638025355;4861.052094841507;4865.099956508039;4876.926846097312;4852.102361063215;4865.732384718839;4866.780994855222;4867.780949857265;4875.390576177978;4563.954360456386;4643.767811609423;4696.295555666643;4767.332573439721;4835.637327200457;4801.4958429365115;4805.351277577517;4823.421189457253;4832.226843705008;4836.347093142434;4243.342281946272;4244.045089854789;4251.171021650779;4253.893652658678;4255.2978758504805;5973;5984.611000284967;6002.459778619946;6008.6094403864045;6076.544259180535;5604.8318550443555;5606.775728970836;5607.747651355658;5609.186667933127;5617;6507.3492650735025;6615.669216539154;6626.13860198176;6640.435562977153;6651.833704157387;4670.299455081731;4687.859364219079;4693.366395536593;4700.130475861976;4705.905881882378;6898.206706228748;6909.170899492043;6911.17065952089;6920.584764914071;6922.826929326807;4750.596199323097;4752.120857641347;4803.543663351976;4805.783739731721;4814.446338671028;4855.830045948445;4875.536824001714;4883.731394773251;4887.218045112765;4894.2658601210105;5554.472325129106;5592.944070559242;5596.132599447093;5598.356189038313;5610.270664813548;6651.135352404156;6658.334166583303;6673.265940746514;6675.299093595199;6683.732650694015;1626.1869065467267;1671.2061770659084;1688.7720157778788;1714.2800023989955;1716.1933891071176;1120.912714666772;1123.9381833999046;1134.309878281355;1135.5457816873152;1135.8750537440874;6421.8073457796345;6430.356964303533;6431.163948686641;6434.227892652912;6438.903416448757;6884.277150899084;6914.619695916773;6924.480663950224;6933.341332573397;6934.098567186234;6423.42189202974;6434.356564343622;6438.195225596801;6438.935610643927;6439.678016099177;3664.3953747631876;3709.536307961505;3710.4805327254207;3715.052661571282;3716.0524066362905;7054.576725396492;7088.113985751781;7232.132144142736;7256.383207427428;7262.673179706926;7017.578945263199;7083.858322833515;7087.149542054986;7093.113360829896;7100.46746494015;7241.275872412716;7258.891116633255;7269.273072692688;7277.16312624055;7283.890741638879;6974.337437943387;6981;6984.441244700513;6988.196357418962;7002.474814388839;6753.220812943252;6809.557378770364;6869.484788640972;6887.827804304932;6897.3447522485285;7215.134183897966;7230.855382892418;7232.710691572489;7233.276672332725;7250.492465527574;4651.790669419816;4683.672142950097;4685.156671798973;4688;4688.835890743944;6617.205935287796;6944.097267355211;6944.687489062903;6946.583205007716;6952.130983627047;6611.371919667624;6742.6628668567355;6744.662766861539;6744.966275168593;6754.797356079325;6683.131192944886;6715.261321254756;6716.194056713226;6720.731170753115;6727.159105111861;6578.967105164444;6599.901001485077;6603.009548567753;6603.570767900071;6605.1083103780375;6623.536352455282;6733.326667333227;6746.089277947414;6746.156730408699;6772.288909664611;6590.868182636416;6599.868002639824;6610.206775187008;6618.338166183343;6626.867462650816 04:25:07 INFO - PROCESS | 17742 | |5;yui.html;880.762194207564;930.5114814722274;939.0327962198933;953.6423841059601;954.2890546542818;15578.688426231469;15807.446739364124;15852.524424267276;15862.682746345066;15880.761788573167;13498;14319.713605727879;14595.051321664085;14755.262236888166;14756.926215368909;897.6319708919344;908.5865931001379;914.1589737441569;915.7756349694334;916.8716379706847;905.180811365715;910.0171814440422;910.3218102513637;910.39003867409;910.81328327693;948.7201275623707;954.6754103604773;954.8233576788282;955.073578628729;955.2549011770795;945.4185675809362;945.8628498867695;946.4747065378712;946.7443790176683;946.9715908522721;692.9688164032581;693.3551796828947;695.2942763095463;695.422799076765;695.5826504097552;13688.452461901612;13718;13745.862541374558;13823.585292441243;13830.654233644138;13328.333583320893;13343.132696374705;13346.933265333708;13454.596362109152;13486.797698034537;11369.022240290336;11409.60066397672;11582.131340149523;11611.94194029033;11826.172167948247;3712.257548490286;3738.869139580129;3752.699784017272;3824.7896365699876;3908.1988192420486;45202.77398613019;48494.515054849355;48622.10692152121;55391.72304138494;55577;11871.821922671166;12564.81152782709;12599;12697.682557936125;12940.870591294155;18933.90533047326;21585.784142158376;21753.67369489459;22085.227017054327;22117.115315387528;9248.21390181842;9296.95351523238;9354.812903741888;9448.95275523618;9490.145886870216;5013.666847563593;5122.513361230752;5150.4334523202415;5243.68537887728;5265.921011184835;3600.2439487707875;3625.1118475973026;3669.3945498992903;3681.7054635629083;3684.097396137963;673.441043933534;675.7769935921134;682.5529278322707;687.4053943338976;691.7959202035412;664.9135612370458;765.9731909383145;773.3194788586121;776.8990031296008;791.7941335252875;10089;10169.338992965433;10251.38491690501;10351.534180961724;10457.633982810565;690.4821383962028;710.1478226128667;736.3520102309933;745.9627018649046;748.0425055928421;4552;4668.439787225555;4747.691400058985;4812.013537224861;4890.731009794425;65954.34045659578;66704.66647666828;67029;68973.65513172402;69334.30665693278;53684.19473707898;54095.72952135214;54482.45517544853;57542.42457575371;59117.113243300526;52630.210546842594;53110.46889531132;53305.2004219937;53989.46010539923;54238.72880635571;9955.950220248853;10343.689689309333;10380.636677716244;10401.739956501147;10507.789844203226;38696.226075478895;39293.607063929;39724.404133938595;40065.399019014156;40075.79962100171;45473;50616.24075638942;51424.74287628538;51525;51752.223716645036;11460.19778615489;11814.763704725685;12130.33283169434;12178.269303841798;12517.812232816697;13797.655058623615;13924.234167120905;14268;14755.926220368829;15321.233938302817;13709.314534273446;13819.654508637364;13914.304284785923;13915.304234788422;14199.361028753938;13564.72870542564;13753.106048106842;13806.585802425943;13898.444062237802;13932.30338483092;13232.867671323163;13929.442822287401;14634.121952682874;14639.121652700873;14645.633859153606;10658.738103419977;10827.783444330911;10999.33857863509;11270.267432616854;11613.76772464563;10301;10504.474776261004;10836.729081772703;10987.230893837674;11185.608503702331 04:25:07 INFO - PROCESS | 17742 | __end_tp_report 04:25:07 INFO - PROCESS | 17742 | __start_cc_report 04:25:07 INFO - PROCESS | 17742 | _x_x_mozilla_cycle_collect,834 04:25:07 INFO - PROCESS | 17742 | __end_cc_report 04:25:07 INFO - PROCESS | 17742 | __startTimestamp1462965907433__endTimestamp 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | ------- Summary: start ------- 04:25:07 INFO - PROCESS | 17742 | Number of tests: 6 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#0] dojo.html Cycles:165 Average:5504.08 Median:5707.77 stddev:614.35 (10.8%) stddev-sans-first:591.33 04:25:07 INFO - PROCESS | 17742 | Values: 3296.8 3357.3 3365.6 3374.5 3403.8 5560.1 5568.9 5593.8 5602.7 5629.7 5594.6 5606.0 5624.2 5628.4 5636.2 5042.6 5095.9 5098.7 5159.5 5214.3 5047.4 5075.1 5088.7 5095.6 5138.5 5021.1 5086.1 5089.9 5092.5 5095.1 5056.7 5131.2 5131.8 5139.6 5144.3 4879.1 4968.2 5030.6 5043.1 5050.4 5401.5 5415.7 5417.0 5418.4 5436.6 5853.3 5884.8 5888.9 5889.2 5894.1 5789.4 5921.8 5955.0 5977.3 5982.7 5514.7 5547.6 5551.9 5554.1 5555.8 5989.5 6018.4 6067.8 6069.5 6077.7 5820.2 5890.3 5921.0 5922.9 5927.0 5924.1 5936.8 5938.0 5942.9 5947.3 5792.6 5906.9 5908.6 5916.2 5920.7 5824.7 5899.2 5940.4 5946.9 5957.1 4456.7 4478.7 4485.3 4486.7 4511.8 3949.1 4016.8 4022.7 4029.1 4035.8 5542.8 5666.3 5667.6 5672.7 5699.8 5990.7 6016.4 6020.6 6023.5 6025.8 5449.5 5649.6 5674.5 5704.6 5707.3 4825.8 4829.8 4832.3 4837.4 4860.5 6117.3 6169.5 6176.9 6178.6 6179.6 5841.8 5964.3 5974.5 5984.1 6006.5 6082.8 6087.7 6089.3 6090.3 6118.8 5776.0 5789.0 5794.3 5795.8 5801.1 5730.7 5891.5 5897.8 5910.8 5967.9 5658.8 5706.4 5755.2 5757.4 5798.8 5707.8 5709.6 5712.5 5717.4 5740.4 5593.3 5620.5 5699.6 5763.7 5773.3 5826.1 5829.3 5837.9 5846.8 5859.8 5704.3 5706.0 5709.0 5712.2 5723.9 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#1] ext.html Cycles:180 Average:57448.68 Median:37737.03 stddev:109166.79 (289.3%) stddev-sans-first:109389.79 04:25:07 INFO - PROCESS | 17742 | Values: 665.9 667.2 671.3 727.2 738.8 31360.4 31859.2 32095.2 38998.6 39360.0 42180.0 42750.1 42787.0 42840.8 42856.1 8750.5 9015.0 9015.6 9016.6 9021.5 8198.0 8657.6 10635.6 10888.0 10893.1 10609.2 10702.3 10704.9 10705.5 10707.9 10462.3 10541.3 10541.3 10554.1 10558.0 10275.5 10336.6 10342.4 10359.2 10366.0 39428.8 43584.6 43744.6 43835.6 43836.0 3752.9 3792.3 3841.5 3873.0 4081.4 32950.5 33307.2 33642.0 34707.3 35446.6 4631.2 4724.1 4737.9 4758.4 4817.5 326783.0 328071.4 328296.0 328484.0 328578.0 39313.6 59889.0 60025.0 60359.7 60439.0 37479.8 37640.8 37731.2 37742.8 37746.0 16847.8 17022.4 17041.0 17056.6 17058.7 12566.7 13592.7 13900.1 14530.5 14603.5 8938.5 8998.2 9025.8 9071.8 9091.0 3547.6 3572.8 3582.8 3588.6 3636.0 1086.1 1115.5 1130.5 1205.6 1254.0 31344.0 31438.4 31528.8 31826.0 32577.3 1202.5 1231.9 1244.0 1273.5 1344.7 17309.9 17626.6 17658.8 17712.0 17784.6 454011.0 455022.0 455638.0 456134.0 458650.0 61848.7 62568.0 63086.7 63093.0 63143.0 1387.7 1394.7 1466.3 1530.6 1540.8 33555.3 37221.2 37251.3 37519.2 37576.6 57212.1 57907.4 58077.0 58426.4 58664.4 436828.0 442767.0 443763.0 447523.0 447913.0 39200.0 45634.0 46190.8 46783.0 47024.8 44192.6 44644.3 44771.3 45217.8 45672.3 37709.6 37996.0 38810.0 39773.0 41798.8 40556.6 40941.6 41366.4 41719.6 42332.8 41927.4 42193.8 42971.6 43247.4 43503.3 34823.5 36367.8 36743.8 36896.0 37467.3 28675.3 28999.0 29063.4 29065.4 29106.0 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#2] jquery.html Cycles:180 Average:31154.17 Median:2111.66 stddev:93713.63 (4437.9%) stddev-sans-first:93948.11 04:25:07 INFO - PROCESS | 17742 | Values: 422.0 424.4 434.2 435.8 438.1 18570.8 19136.9 19338.4 19440.8 20340.2 12546.9 12847.2 13569.9 19871.0 19872.3 5234.4 5393.7 5398.6 5427.3 5547.7 5730.3 5832.9 5838.6 5867.2 5873.9 5492.5 5801.5 5837.2 5844.9 5846.5 5354.4 5384.1 5391.7 5395.0 5399.4 5163.3 5196.9 5203.4 5203.4 5205.7 13389.8 13852.2 13918.2 13925.8 13940.4 2467.0 2538.7 2568.5 2910.9 3061.6 10179.8 10213.8 10344.8 10574.8 10943.3 1948.9 1973.9 2100.4 2119.6 2131.2 79255.6 79844.6 79860.0 81545.6 81904.6 11111.8 11272.5 11939.3 11995.1 12016.2 16720.4 16822.7 17076.1 17082.5 17108.2 9177.4 9180.5 9247.2 9259.2 9271.2 9057.0 9075.9 9106.0 9187.6 9243.3 5093.4 5108.9 5124.0 5148.0 5160.4 2050.9 2076.4 2086.4 2110.0 2113.4 1007.0 1084.6 1120.7 1128.4 1134.8 18734.2 19237.0 19704.8 19783.2 20061.0 1056.2 1060.9 1064.6 1075.1 1082.4 8116.4 11073.3 11178.5 11368.7 11384.5 557251.0 562646.0 570748.0 579714.0 582212.0 81586.2 95274.0 95283.0 95768.0 97195.5 1082.6 1115.7 1122.5 1129.8 1137.5 17101.4 17224.5 17250.4 17327.7 17473.0 40320.0 40943.2 41088.4 42014.8 42745.4 57663.0 58496.7 58594.7 58622.0 58944.7 8604.2 9175.1 9191.8 9199.8 9772.6 11776.5 13738.5 13880.8 13966.4 14113.6 12307.8 12495.3 12641.5 12690.2 12853.9 12079.5 12139.9 12359.3 12435.4 12458.9 11913.9 12001.6 12009.6 12463.5 12512.2 8474.5 8784.5 8965.6 9121.8 9171.8 11280.5 11652.2 12241.8 12257.1 12396.8 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#3] mootools.html Cycles:180 Average:5516.31 Median:5135.46 stddev:3018.03 (58.8%) stddev-sans-first:3010.65 04:25:07 INFO - PROCESS | 17742 | Values: 1401.1 1543.1 1544.7 1757.5 1861.0 7826.4 8056.4 8058.0 8075.6 8081.6 7876.6 8061.5 8062.8 8066.4 8084.4 2026.7 2066.0 2066.8 2277.1 2318.3 2216.0 2264.8 2269.0 2276.0 2277.2 2241.0 2284.0 2295.1 2295.6 2317.4 2014.1 2055.3 2309.0 2328.7 2331.9 1972.4 2204.5 2266.8 2266.9 2268.5 7932.2 7935.1 7940.7 7953.6 7956.1 5010.1 5093.8 5122.8 5131.9 5139.0 3358.0 3411.4 3448.0 3456.8 3476.3 1224.9 1244.2 1259.0 1281.9 1353.1 11629.6 11665.1 11670.8 11687.8 11690.2 4464.3 4539.1 4581.2 4585.3 4644.8 9875.6 9886.6 9892.7 9913.2 9918.5 5163.5 5169.5 5194.0 5206.0 5207.5 4239.9 4504.8 4632.3 4793.6 4813.2 3936.6 3993.8 4065.4 4097.7 4129.3 1286.6 1304.1 1307.1 1315.6 1328.3 1064.8 1076.1 1079.7 1080.4 1085.3 5807.4 5873.1 5923.0 5954.8 6008.3 482.6 484.7 491.1 491.9 501.0 4122.1 4138.7 4145.4 4197.4 4199.0 9655.7 9841.2 9899.5 10261.8 10329.2 9634.8 9722.7 9882.2 9905.9 9910.7 7428.2 7572.5 7639.8 8115.2 8183.1 5983.4 5999.4 6070.3 6077.5 6132.6 9116.2 9118.9 9202.1 9252.8 9400.4 9123.4 9291.0 9302.7 9336.0 9519.4 6671.5 7030.3 7198.1 7488.3 7586.6 7962.6 7987.7 8026.2 8061.8 8068.9 6874.4 7279.3 7349.6 7353.9 7482.4 7184.6 7197.6 7203.1 7242.8 7321.2 6820.7 6835.4 6913.8 6919.3 6924.1 5006.2 5073.3 5075.0 5088.2 5089.6 5235.6 5295.0 5306.3 5315.9 5423.7 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#4] prototype.html Cycles:180 Average:5610.89 Median:6422.61 stddev:1694.39 (26.4%) stddev-sans-first:1652.25 04:25:07 INFO - PROCESS | 17742 | Values: 336.2 351.3 358.7 368.4 369.8 6314.7 6319.0 6354.8 6384.7 6389.5 6010.9 6152.6 6308.3 6314.1 6338.7 4834.5 4857.7 4861.1 4865.1 4876.9 4852.1 4865.7 4866.8 4867.8 4875.4 4564.0 4643.8 4696.3 4767.3 4835.6 4801.5 4805.4 4823.4 4832.2 4836.3 4243.3 4244.0 4251.2 4253.9 4255.3 5973.0 5984.6 6002.5 6008.6 6076.5 5604.8 5606.8 5607.7 5609.2 5617.0 6507.3 6615.7 6626.1 6640.4 6651.8 4670.3 4687.9 4693.4 4700.1 4705.9 6898.2 6909.2 6911.2 6920.6 6922.8 4750.6 4752.1 4803.5 4805.8 4814.4 4855.8 4875.5 4883.7 4887.2 4894.3 5554.5 5592.9 5596.1 5598.4 5610.3 6651.1 6658.3 6673.3 6675.3 6683.7 1626.2 1671.2 1688.8 1714.3 1716.2 1120.9 1123.9 1134.3 1135.5 1135.9 6421.8 6430.4 6431.2 6434.2 6438.9 6884.3 6914.6 6924.5 6933.3 6934.1 6423.4 6434.4 6438.2 6438.9 6439.7 3664.4 3709.5 3710.5 3715.1 3716.1 7054.6 7088.1 7232.1 7256.4 7262.7 7017.6 7083.9 7087.1 7093.1 7100.5 7241.3 7258.9 7269.3 7277.2 7283.9 6974.3 6981.0 6984.4 6988.2 7002.5 6753.2 6809.6 6869.5 6887.8 6897.3 7215.1 7230.9 7232.7 7233.3 7250.5 4651.8 4683.7 4685.2 4688.0 4688.8 6617.2 6944.1 6944.7 6946.6 6952.1 6611.4 6742.7 6744.7 6745.0 6754.8 6683.1 6715.3 6716.2 6720.7 6727.2 6579.0 6599.9 6603.0 6603.6 6605.1 6623.5 6733.3 6746.1 6746.2 6772.3 6590.9 6599.9 6610.2 6618.3 6626.9 04:25:07 INFO - PROCESS | 17742 | 04:25:07 INFO - PROCESS | 17742 | [#5] yui.html Cycles:180 Average:15692.52 Median:39509.01 stddev:17909.53 (45.3%) stddev-sans-first:17925.22 04:25:07 INFO - PROCESS | 17742 | Values: 880.8 930.5 939.0 953.6 954.3 15578.7 15807.4 15852.5 15862.7 15880.8 13498.0 14319.7 14595.1 14755.3 14756.9 897.6 908.6 914.2 915.8 916.9 905.2 910.0 910.3 910.4 910.8 948.7 954.7 954.8 955.1 955.3 945.4 945.9 946.5 946.7 947.0 693.0 693.4 695.3 695.4 695.6 13688.5 13718.0 13745.9 13823.6 13830.7 13328.3 13343.1 13346.9 13454.6 13486.8 11369.0 11409.6 11582.1 11611.9 11826.2 3712.3 3738.9 3752.7 3824.8 3908.2 45202.8 48494.5 48622.1 55391.7 55577.0 11871.8 12564.8 12599.0 12697.7 12940.9 18933.9 21585.8 21753.7 22085.2 22117.1 9248.2 9297.0 9354.8 9449.0 9490.1 5013.7 5122.5 5150.4 5243.7 5265.9 3600.2 3625.1 3669.4 3681.7 3684.1 673.4 675.8 682.6 687.4 691.8 664.9 766.0 773.3 776.9 791.8 10089.0 10169.3 10251.4 10351.5 10457.6 690.5 710.1 736.4 746.0 748.0 4552.0 4668.4 4747.7 4812.0 4890.7 65954.3 66704.7 67029.0 68973.7 69334.3 53684.2 54095.7 54482.5 57542.4 59117.1 52630.2 53110.5 53305.2 53989.5 54238.7 9956.0 10343.7 10380.6 10401.7 10507.8 38696.2 39293.6 39724.4 40065.4 40075.8 45473.0 50616.2 51424.7 51525.0 51752.2 11460.2 11814.8 12130.3 12178.3 12517.8 13797.7 13924.2 14268.0 14755.9 15321.2 13709.3 13819.7 13914.3 13915.3 14199.4 13564.7 13753.1 13806.6 13898.4 13932.3 13232.9 13929.4 14634.1 14639.1 14645.6 10658.7 10827.8 10999.3 11270.3 11613.8 10301.0 10504.5 10836.7 10987.2 11185.6 04:25:07 INFO - PROCESS | 17742 | -------- Summary: end -------- 04:25:07 INFO - PROCESS | 17742 | 04:25:08 INFO - TEST-INFO | 17742: exit 0 04:25:08 INFO - TEST-OK | dromaeo_css | took 1111343ms 04:25:08 INFO - TEST-START | kraken 04:25:08 INFO - operating with platform_type : linux_ 04:25:08 INFO - Initialising browser for kraken test... 04:25:08 INFO - TEST-INFO | started process 17932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7EABMQ/profile http://localhost:49153/getInfo.html) 04:25:12 INFO - PROCESS | 17932 | __metrics Screen width/height:1600/1200 04:25:12 INFO - PROCESS | 17932 | colorDepth:24 04:25:12 INFO - PROCESS | 17932 | Browser inner width/height: 1024/697 04:25:12 INFO - PROCESS | 17932 | __metrics 04:25:13 ERROR - PROCESS | 17932 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:25:13 INFO - TEST-INFO | 17932: exit 0 04:25:13 INFO - Browser initialized. 04:25:13 INFO - Running cycle 1/1 for kraken test... 04:25:13 INFO - TEST-INFO | started process 18021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7EABMQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:25 INFO - PROCESS | 18021 | RSS: Main: 142323712 04:25:25 INFO - PROCESS | 18021 | 04:25:28 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49153/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:29 INFO - PROCESS | 18021 | RSS: Main: 196337664 04:25:29 INFO - PROCESS | 18021 | 04:25:31 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49153/tests/kraken/driver.html?testName=audio-dft) 04:25:32 INFO - PROCESS | 18021 | RSS: Main: 182476800 04:25:32 INFO - PROCESS | 18021 | 04:25:35 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49153/tests/kraken/driver.html?testName=audio-fft) 04:25:35 INFO - PROCESS | 18021 | RSS: Main: 272764928 04:25:35 INFO - PROCESS | 18021 | 04:25:37 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49153/tests/kraken/driver.html?testName=audio-oscillator) 04:25:38 INFO - PROCESS | 18021 | RSS: Main: 179396608 04:25:38 INFO - PROCESS | 18021 | 04:25:40 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:41 INFO - PROCESS | 18021 | RSS: Main: 177688576 04:25:41 INFO - PROCESS | 18021 | 04:25:44 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49153/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:44 INFO - PROCESS | 18021 | RSS: Main: 212230144 04:25:44 INFO - PROCESS | 18021 | 04:25:48 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49153/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:48 INFO - PROCESS | 18021 | RSS: Main: 212844544 04:25:48 INFO - PROCESS | 18021 | 04:25:51 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49153/tests/kraken/driver.html?testName=json-parse-financial) 04:25:51 INFO - PROCESS | 18021 | RSS: Main: 212107264 04:25:51 INFO - PROCESS | 18021 | 04:25:53 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:54 INFO - PROCESS | 18021 | RSS: Main: 192409600 04:25:54 INFO - PROCESS | 18021 | 04:25:55 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:56 INFO - PROCESS | 18021 | RSS: Main: 197185536 04:25:56 INFO - PROCESS | 18021 | 04:25:58 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:59 INFO - PROCESS | 18021 | RSS: Main: 209797120 04:25:59 INFO - PROCESS | 18021 | 04:26:01 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:02 INFO - PROCESS | 18021 | RSS: Main: 215293952 04:26:02 INFO - PROCESS | 18021 | 04:26:04 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:05 INFO - PROCESS | 18021 | RSS: Main: 213139456 04:26:05 INFO - PROCESS | 18021 | 04:26:06 INFO - PROCESS | 18021 | Cycle 1(1): loaded http://localhost:49153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49153/tests/kraken/driver.html?testName=ai-astar) 04:26:07 INFO - PROCESS | 18021 | RSS: Main: 276553728 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | __start_tp_report 04:26:07 INFO - PROCESS | 18021 | _x_x_mozilla_page_load 04:26:07 INFO - PROCESS | 18021 | _x_x_mozilla_page_load_details 04:26:07 INFO - PROCESS | 18021 | |i|pagename|runs| 04:26:07 INFO - PROCESS | 18021 | |0;ai-astar;113;114;113;111;112;113;109;112;112;110 04:26:07 INFO - PROCESS | 18021 | |1;audio-beat-detection;164;126;155;180;127;155;162;135;193;127 04:26:07 INFO - PROCESS | 18021 | |2;audio-dft;160;162;161;161;162;160;160;160;160;161 04:26:07 INFO - PROCESS | 18021 | |3;audio-fft;77;77;76;174;74;77;76;79;160;77 04:26:07 INFO - PROCESS | 18021 | |4;audio-oscillator;94;92;157;92;92;93;151;93;92;149 04:26:07 INFO - PROCESS | 18021 | |5;imaging-gaussian-blur;117;116;117;116;116;117;117;116;117;117 04:26:07 INFO - PROCESS | 18021 | |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;146 04:26:07 INFO - PROCESS | 18021 | |7;imaging-desaturate;95;95;95;95;94;95;96;96;95;96 04:26:07 INFO - PROCESS | 18021 | |8;json-parse-financial;54;55;53;54;54;55;53;75;54;58 04:26:07 INFO - PROCESS | 18021 | |9;json-stringify-tinderbox;58;58;58;58;57;57;58;57;58;58 04:26:07 INFO - PROCESS | 18021 | |10;stanford-crypto-aes;72;72;72;80;75;75;73;73;76;82 04:26:07 INFO - PROCESS | 18021 | |11;stanford-crypto-ccm;113;120;111;115;121;111;111;114;135;135 04:26:07 INFO - PROCESS | 18021 | |12;stanford-crypto-pbkdf2;159;157;159;159;157;159;162;157;156;162 04:26:07 INFO - PROCESS | 18021 | |13;stanford-crypto-sha256-iterative;68;64;65;67;65;67;66;66;67;66 04:26:07 INFO - PROCESS | 18021 | __end_tp_report 04:26:07 INFO - PROCESS | 18021 | __start_cc_report 04:26:07 INFO - PROCESS | 18021 | _x_x_mozilla_cycle_collect,1595 04:26:07 INFO - PROCESS | 18021 | __end_cc_report 04:26:07 INFO - PROCESS | 18021 | __startTimestamp1462965967205__endTimestamp 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | ------- Summary: start ------- 04:26:07 INFO - PROCESS | 18021 | Number of tests: 14 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.52 (1.4%) stddev-sans-first:1.56 04:26:07 INFO - PROCESS | 18021 | Values: 113.0 114.0 113.0 111.0 112.0 113.0 109.0 112.0 112.0 110.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:158.50 stddev:23.43 (14.8%) stddev-sans-first:24.47 04:26:07 INFO - PROCESS | 18021 | Values: 164.0 126.0 155.0 180.0 127.0 155.0 162.0 135.0 193.0 127.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:26:07 INFO - PROCESS | 18021 | Values: 160.0 162.0 161.0 161.0 162.0 160.0 160.0 160.0 160.0 161.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#3] audio-fft Cycles:10 Average:94.70 Median:77.00 stddev:38.27 (49.7%) stddev-sans-first:40.05 04:26:07 INFO - PROCESS | 18021 | Values: 77.0 77.0 76.0 174.0 74.0 77.0 76.0 79.0 160.0 77.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:28.94 (31.5%) stddev-sans-first:30.07 04:26:07 INFO - PROCESS | 18021 | Values: 94.0 92.0 157.0 92.0 92.0 93.0 151.0 93.0 92.0 149.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:26:07 INFO - PROCESS | 18021 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:26:07 INFO - PROCESS | 18021 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:26:07 INFO - PROCESS | 18021 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 96.0 96.0 95.0 96.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:54.50 stddev:6.65 (12.2%) stddev-sans-first:7.00 04:26:07 INFO - PROCESS | 18021 | Values: 54.0 55.0 53.0 54.0 54.0 55.0 53.0 75.0 54.0 58.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:26:07 INFO - PROCESS | 18021 | Values: 58.0 58.0 58.0 58.0 57.0 57.0 58.0 57.0 58.0 58.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:3.50 (4.7%) stddev-sans-first:3.54 04:26:07 INFO - PROCESS | 18021 | Values: 72.0 72.0 72.0 80.0 75.0 75.0 73.0 73.0 76.0 82.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:117.50 stddev:9.34 (7.9%) stddev-sans-first:9.68 04:26:07 INFO - PROCESS | 18021 | Values: 113.0 120.0 111.0 115.0 121.0 111.0 111.0 114.0 135.0 135.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 04:26:07 INFO - PROCESS | 18021 | Values: 159.0 157.0 159.0 159.0 157.0 159.0 162.0 157.0 156.0 162.0 04:26:07 INFO - PROCESS | 18021 | 04:26:07 INFO - PROCESS | 18021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.05 04:26:07 INFO - PROCESS | 18021 | Values: 68.0 64.0 65.0 67.0 65.0 67.0 66.0 66.0 67.0 66.0 04:26:07 INFO - PROCESS | 18021 | -------- Summary: end -------- 04:26:07 INFO - PROCESS | 18021 | 04:26:08 INFO - TEST-INFO | 18021: exit 0 04:26:08 INFO - TEST-OK | kraken | took 60048ms 04:26:08 INFO - SUITE-END | took 1171s 04:26:08 INFO - Completed test suite (00:19:31) 04:26:08 INFO - javascript benchmark 04:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.8351582420883, 3357.278185190185, 3365.5961284645814, 3374.52756614074, 3403.8468268927913, 5560.082586373249, 5568.888622227558, 5593.804216852411, 5602.691851948151, 5629.746661400237, 5594.608377413582, 5605.971970140154, 5624.15637654352, 5628.380878103405, 5636.182902584493, 5042.621803364744, 5095.923561146586, 5098.745062746875, 5159.509846564571, 5214.270002199695, 5047.394312682483, 5075.137226671474, 5088.669236499634, 5095.566876815476, 5138.486151384869, 5021.1213037718435, 5086.135356989321, 5089.949100508985, 5092.516210959953, 5095.133827249377, 5056.696598204083, 5131.204663277198, 5131.794728210867, 5139.640225184257, 5144.279800827869, 4879.146149423872, 4968.180250258703, 5030.622703297231, 5043.067032598981, 5050.39395272566, 5401.4868587484125, 5415.675059496403, 5416.972915135439, 5418.431064738224, 5436.592255580847, 5853.268341457318, 5884.764609415618, 5888.941110588882, 5889.234399528077, 5894.056950887837, 5789.421057894219, 5921.792737254218, 5955.047192449188, 5977.252843394575, 5982.670953097621, 5514.6691198527815, 5547.611667183299, 5551.861203469905, 5554.1391084381985, 5555.777768889239, 5989.490893274121, 6018.398160183947, 6067.848303792441, 6069.514438844882, 6077.6961151943115, 5820.214271073351, 5890.293164820249, 5921.023031199804, 5922.940770592325, 5926.970365148147, 5924.052151655715, 5936.821895343147, 5938.0, 5942.910856337158, 5947.316058653224, 5792.565557583114, 5906.911396329058, 5908.556858235649, 5916.2013128228, 5920.674362910081, 5824.708764561755, 5899.203607513016, 5940.405959404112, 5946.85132871673, 5957.076653118774, 4456.68803183774, 4478.664100192498, 4485.304777759453, 4486.730796152176, 4511.796969136397, 3949.1114499238015, 4016.779077150726, 4022.7184097113504, 4029.0531725044593, 4035.8385664573675, 5542.806001789918, 5666.320041595035, 5667.631603945731, 5672.744726487318, 5699.82900512977, 5990.7004649768205, 6016.368281330485, 6020.638761674313, 6023.45788879003, 6025.849353766191, 5449.509544141047, 5649.604527683023, 5674.546036317085, 5704.600677952503, 5707.286589176353, 4825.831095911626, 4829.830955916596, 4832.323474713543, 4837.419509658864, 4860.538248866352, 6117.265928088658, 6169.537284703575, 6176.907346389808, 6178.62928224308, 6179.567430279837, 5841.795537156349, 5964.31410387811, 5974.4622983930785, 5984.1323008164445, 6006.459418652343, 6082.817515474543, 6087.66517841523, 6089.2997305310455, 6090.269167699905, 6118.816435506942, 5776.0, 5788.971055144697, 5794.333651629948, 5795.797147099831, 5801.129830525286, 5730.713464326684, 5891.528677705687, 5897.764089436375, 5910.793122240873, 5967.880642387215, 5658.801941932013, 5706.400827913009, 5755.223044888887, 5757.424257574209, 5798.82603521895, 5707.771689132388, 5709.628874123168, 5712.485876270989, 5717.42825717425, 5740.425957404226, 5593.272874526286, 5620.522255608319, 5699.629524080921, 5763.6541807491685, 5773.307203135482, 5826.067829147316, 5829.329627092939, 5837.912431313449, 5846.824595262149, 5859.794907178229, 5704.286964129484, 5705.971470142623, 5709.029464990878, 5712.200291959212, 5723.942760572341], "value": 5464.00530775748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.9001149827528, 667.2326824152227, 671.348791672078, 727.2436665867498, 738.8337624034591, 31360.372792544134, 31859.203519911985, 32095.19762005951, 38998.610013899925, 39360.0, 42180.0, 42750.14499710004, 42787.0, 42840.78579607105, 42856.14287714244, 8750.518721470333, 9015.0, 9015.639374425014, 9016.59425325862, 9021.548922553879, 8198.0, 8657.567121643924, 10635.627753028646, 10888.0, 10893.128549716004, 10609.204309676805, 10702.30435021725, 10704.875988021262, 10705.518251678694, 10707.946460267687, 10462.267641265114, 10541.26211165215, 10541.31481453703, 10554.102901253402, 10558.049775520163, 10275.48622568876, 10336.586536538529, 10342.37945723259, 10359.22305827066, 10366.0, 39428.8171354857, 43584.56415435868, 43744.562554374366, 43835.561644383466, 43836.0, 3752.9437058444146, 3792.2984247914223, 3841.4621952926614, 3872.9806350968347, 4081.3673880548267, 32950.50574241388, 33307.16732081693, 33642.0, 34707.30585388303, 35446.64553354485, 4631.235846085392, 4724.149653062447, 4737.881552961204, 4758.357621721093, 4817.470078291421, 326783.0, 328071.3596432026, 328296.0, 328484.0, 328578.0, 39313.606863930996, 59889.0, 60025.0, 60359.69820150959, 60439.0, 37479.81260093682, 37640.81179594085, 37731.245375092345, 37742.8112859434, 37746.0, 16847.83152168487, 17022.404215852384, 17041.0, 17056.57358566046, 17058.65882682364, 12566.748665026647, 13592.728145437035, 13900.096493727875, 14530.491432799801, 14603.488877889435, 8938.46369217849, 8998.190162885372, 9025.774355641162, 9071.818563628822, 9090.954545227232, 3547.5565554305713, 3572.821358932043, 3582.8387722552548, 3588.5873124590485, 3635.9818200909353, 1086.0768346905224, 1115.4924509348227, 1130.5421304371744, 1205.6322821539516, 1253.95611153611, 31344.0, 31438.37123257522, 31528.842355788074, 31826.0, 32577.348453030805, 1202.4949521201117, 1231.9322437266037, 1243.975120497585, 1273.5160638957136, 1344.683999260173, 17309.91345043267, 17626.64746705059, 17658.823411765974, 17712.0, 17784.644307113784, 454011.0, 455022.0, 455638.0, 456134.0, 458650.0, 61848.690756545926, 62568.0, 63086.68456657687, 63093.0, 63143.0, 1387.6877702516854, 1394.741972735027, 1466.30350583472, 1530.556138719781, 1540.8459154084726, 33555.328893422484, 37221.1752270984, 37251.25497490089, 37519.24961500809, 37576.62423375731, 57212.14181787193, 57907.420925790204, 58077.0, 58426.4157358421, 58664.413355867604, 436828.0, 442767.0, 443763.0, 447523.0, 447913.0, 39200.0, 45634.0, 46190.76904615456, 46783.0, 47024.7648761754, 44192.55807442013, 44644.33033504435, 44771.32843007422, 45217.773911130236, 45672.31491527696, 37709.622903771706, 37996.0, 38810.0, 39773.0, 41798.791006044776, 40556.59443405528, 40941.59058409378, 41366.37950430806, 41719.58280417157, 42332.788336058125, 41927.37108943307, 42193.78903105465, 42971.57028429801, 43247.35128973005, 43503.34744978891, 34823.4776478348, 36367.818160909024, 36743.81628091842, 36896.0, 37467.25065498729, 28675.28311792222, 28999.0, 29063.418731624824, 29065.418691626473, 29106.0], "value": 20020.74535546431, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.9620234178924, 424.40583183543043, 434.2379124636263, 435.79735423028285, 438.0691031557939, 18570.814291857077, 19136.90431547842, 19338.419847404584, 19440.805591944078, 20340.186392544318, 12546.937265313683, 12847.164934279288, 13569.932150339235, 19871.0, 19872.30446934354, 5234.42421333654, 5393.6763794172475, 5398.649087809299, 5427.294451721291, 5547.694876781776, 5730.341010783751, 5832.854178645525, 5838.562107841907, 5867.2372591563035, 5873.853153671171, 5492.450754924495, 5801.535877129841, 5837.1536127261525, 5844.853878653046, 5846.532277417797, 5354.437784032699, 5384.084705600018, 5391.703456309901, 5395.001924643934, 5399.379071406799, 5163.32876726027, 5196.948030519722, 5203.375594928595, 5203.427622961509, 5205.739713014372, 13389.799153012713, 13852.238126903016, 13918.164910105324, 13925.79111313321, 13940.442382304696, 2466.9753302466925, 2538.7334329895466, 2568.460623269116, 2910.941781164386, 3061.5713800068006, 10179.796404071878, 10213.846792298122, 10344.844827327595, 10574.841377379345, 10943.343399395982, 1948.856258116061, 1973.8716983396178, 2100.4013856051106, 2119.6078725435846, 2131.211451762842, 79255.60372198102, 79844.60077699632, 79859.99999999942, 81545.59227203885, 81904.59047704723, 11111.777764444665, 11272.492737826817, 11939.283642981449, 11995.100367472474, 12016.218945768496, 16720.411560901695, 16822.747658785127, 17076.146192690318, 17082.487525374258, 17108.230129644195, 9177.449353038839, 9180.531115021698, 9247.213986811063, 9259.212966897754, 9271.165595096474, 9057.049009854003, 9075.909240907506, 9106.0, 9187.63249470027, 9243.26053915685, 5093.388793344822, 5108.948910510921, 5124.0, 5148.0, 5160.40655324635, 2050.9487262818548, 2076.449740818654, 2086.35323049855, 2109.963884851126, 2113.3554265949033, 1006.9949650251848, 1084.6095405653957, 1120.6806060272784, 1128.4019469680918, 1134.7673726885969, 18734.156962936428, 19237.0, 19704.802951970298, 19783.20867165326, 20061.0, 1056.1603525197334, 1060.9363438193734, 1064.6000509330206, 1075.1130317488103, 1082.4209048159355, 8116.35069194463, 11073.335599864035, 11178.496967636476, 11368.658940231806, 11384.487698053608, 557251.0, 562646.0, 570748.0, 579714.0, 582212.0, 81586.18413815786, 95274.0, 95283.0, 95768.0, 97195.51402243086, 1082.6210826210763, 1115.704338350354, 1122.4948773052158, 1129.824877144044, 1137.4881303413497, 17101.401450949157, 17224.483265502055, 17250.396236131674, 17327.740083899003, 17473.038982856066, 40319.99200020023, 40943.18113637651, 41088.38367424551, 42014.78992605017, 42745.35881961711, 57663.0, 58496.70751646214, 58594.7070264663, 58622.0, 58944.705276473345, 8604.225619694258, 9175.08249175077, 9191.77020574491, 9199.816003680024, 9772.56023478931, 11776.52893884235, 13738.450461981409, 13880.791788123388, 13966.371513281723, 14113.647158821112, 12307.75384492323, 12495.312757798409, 12641.494340226289, 12690.175138615961, 12853.871461285267, 12079.456424460745, 12139.878601214228, 12359.32023738703, 12435.37823108859, 12458.937705311415, 11913.880861191625, 12001.63995080149, 12009.579664711693, 12463.501459941863, 12512.249265044127, 8474.491530508189, 8784.472931624123, 8965.596548155218, 9121.817563648823, 9171.770705732144, 11280.49237784318, 11652.184347095623, 12241.764377442869, 12257.14200005991, 12396.81404778911], "value": 9418.916443271133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.117296103456, 1543.058734172155, 1544.7065057639047, 1757.481542944831, 1860.9906950465254, 7826.413019023575, 8056.436049476539, 8058.0, 8075.596220188996, 8081.595920203996, 7876.606169691507, 8061.516309021463, 8062.838743225132, 8066.3546916246705, 8084.393670474723, 2026.71625972364, 2066.0392917293457, 2066.803653652908, 2277.089164334267, 2318.3392733071078, 2216.036024329414, 2264.784845439689, 2269.024319542596, 2275.977240227593, 2277.191596983072, 2240.9887950560224, 2284.0, 2295.1393227539675, 2295.6326987681973, 2317.397476656073, 2014.0735261779598, 2055.3320170944503, 2308.988455057722, 2328.673985642003, 2331.8834058297102, 1972.437855211258, 2204.5260269042233, 2266.841321107523, 2266.9319920402413, 2268.5009297954425, 7932.2067793220795, 7935.087464941548, 7940.682372705142, 7953.642086106139, 7956.085050219183, 5010.073136469765, 5093.821716239951, 5122.769475373617, 5131.923021154686, 5139.0, 3357.9832100839585, 3411.4371128763723, 3448.0345503259127, 3456.827158642058, 3476.3394954958476, 1224.8897599216025, 1244.1850587864872, 1259.0, 1281.88463038327, 1353.1407556201784, 11629.592964246296, 11665.066794656406, 11670.76658466826, 11687.766244675144, 11690.240134391237, 4464.263396539534, 4539.0694907543875, 4581.244094724333, 4585.335126406652, 4644.767761611906, 9875.555599998017, 9886.604535818631, 9892.65375711861, 9913.157381622499, 9918.454485003249, 5163.509466600667, 5169.53474187325, 5193.974030129901, 5206.0, 5207.531322181022, 4239.872803815891, 4504.842330518416, 4632.305154226826, 4793.616510679138, 4813.15769740294, 3936.566977632458, 3993.7603743775467, 4065.3901914712437, 4097.672186225095, 4129.339305711072, 1286.6397408725572, 1304.1327517200955, 1307.1438207973792, 1315.5921664284103, 1328.3225554967037, 1064.8189807732704, 1076.079951641351, 1079.6868908016588, 1080.4165750494801, 1085.2891356161726, 5807.390224026416, 5873.089671100986, 5922.970385148046, 5954.76180952757, 6008.309044459856, 482.6404328775085, 484.71159660002945, 491.0694234425743, 491.91391506486224, 501.00050399453323, 4122.072533679958, 4138.730982486129, 4145.357469592218, 4197.433346498184, 4198.958010419918, 9655.662051828152, 9841.163501102343, 9899.455529945923, 10261.846072308921, 10329.173666106693, 9634.759131021781, 9722.708318750449, 9882.160016398542, 9905.851412228822, 9910.702678919644, 7428.182899881009, 7572.4699271050495, 7639.770806875803, 8115.188481151956, 8183.099859015503, 5983.431574000463, 5999.370066143167, 6070.332263451105, 6077.453029227391, 6132.601380910227, 9116.225120864536, 9118.863217051618, 9202.079792020744, 9252.768680783034, 9400.388974716621, 9123.406978546373, 9290.95354523223, 9302.674406395743, 9336.0, 9519.38124021964, 6671.46628269747, 7030.261822508563, 7198.100237470317, 7488.251174882686, 7586.582737949466, 7962.601869906597, 7987.720429784929, 8026.237507436784, 8061.758147255592, 8068.919310806817, 6874.381305682513, 7279.272072792678, 7349.6325183741665, 7353.852922941618, 7482.438817088849, 7184.6048467334795, 7197.604131772803, 7203.123530896407, 7242.818929526804, 7321.158066822383, 6820.658967051727, 6835.350641689031, 6913.758018469531, 6919.273476284918, 6924.065251191226, 5006.224035274538, 5073.2897394365555, 5074.974625126851, 5088.211327244283, 5089.643724939218, 5235.63350565472, 5295.0, 5306.310179676618, 5315.867103322448, 5423.701696406578], "value": 4433.982872743377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.24345223247695, 351.2868876181351, 358.72019824536864, 368.35905524387573, 369.7596562234549, 6314.684265786709, 6319.0, 6354.777582784598, 6384.744610215585, 6389.488840892717, 6010.8797824043495, 6152.600080994744, 6308.337624549425, 6314.084457753623, 6338.714757835897, 4834.4923783002805, 4857.6599638025355, 4861.052094841507, 4865.099956508039, 4876.926846097312, 4852.102361063215, 4865.732384718839, 4866.780994855222, 4867.780949857265, 4875.390576177978, 4563.954360456386, 4643.767811609423, 4696.295555666643, 4767.332573439721, 4835.637327200457, 4801.4958429365115, 4805.351277577517, 4823.421189457253, 4832.226843705008, 4836.347093142434, 4243.342281946272, 4244.045089854789, 4251.171021650779, 4253.893652658678, 4255.2978758504805, 5973.0, 5984.611000284967, 6002.459778619946, 6008.6094403864045, 6076.544259180535, 5604.8318550443555, 5606.775728970836, 5607.747651355658, 5609.186667933127, 5617.0, 6507.3492650735025, 6615.669216539154, 6626.13860198176, 6640.435562977153, 6651.833704157387, 4670.299455081731, 4687.859364219079, 4693.366395536593, 4700.130475861976, 4705.905881882378, 6898.206706228748, 6909.170899492043, 6911.17065952089, 6920.584764914071, 6922.826929326807, 4750.596199323097, 4752.120857641347, 4803.543663351976, 4805.783739731721, 4814.446338671028, 4855.830045948445, 4875.536824001714, 4883.731394773251, 4887.218045112765, 4894.2658601210105, 5554.472325129106, 5592.944070559242, 5596.132599447093, 5598.356189038313, 5610.270664813548, 6651.135352404156, 6658.334166583303, 6673.265940746514, 6675.299093595199, 6683.732650694015, 1626.1869065467267, 1671.2061770659084, 1688.7720157778788, 1714.2800023989955, 1716.1933891071176, 1120.912714666772, 1123.9381833999046, 1134.309878281355, 1135.5457816873152, 1135.8750537440874, 6421.8073457796345, 6430.356964303533, 6431.163948686641, 6434.227892652912, 6438.903416448757, 6884.277150899084, 6914.619695916773, 6924.480663950224, 6933.341332573397, 6934.098567186234, 6423.42189202974, 6434.356564343622, 6438.195225596801, 6438.935610643927, 6439.678016099177, 3664.3953747631876, 3709.536307961505, 3710.4805327254207, 3715.052661571282, 3716.0524066362905, 7054.576725396492, 7088.113985751781, 7232.132144142736, 7256.383207427428, 7262.673179706926, 7017.578945263199, 7083.858322833515, 7087.149542054986, 7093.113360829896, 7100.46746494015, 7241.275872412716, 7258.891116633255, 7269.273072692688, 7277.16312624055, 7283.890741638879, 6974.337437943387, 6981.0, 6984.441244700513, 6988.196357418962, 7002.474814388839, 6753.220812943252, 6809.557378770364, 6869.484788640972, 6887.827804304932, 6897.3447522485285, 7215.134183897966, 7230.855382892418, 7232.710691572489, 7233.276672332725, 7250.492465527574, 4651.790669419816, 4683.672142950097, 4685.156671798973, 4688.0, 4688.835890743944, 6617.205935287796, 6944.097267355211, 6944.687489062903, 6946.583205007716, 6952.130983627047, 6611.371919667624, 6742.6628668567355, 6744.662766861539, 6744.966275168593, 6754.797356079325, 6683.131192944886, 6715.261321254756, 6716.194056713226, 6720.731170753115, 6727.159105111861, 6578.967105164444, 6599.901001485077, 6603.009548567753, 6603.570767900071, 6605.1083103780375, 6623.536352455282, 6733.326667333227, 6746.089277947414, 6746.156730408699, 6772.288909664611, 6590.868182636416, 6599.868002639824, 6610.206775187008, 6618.338166183343, 6626.867462650816], "value": 5059.0601842342, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.762194207564, 930.5114814722274, 939.0327962198933, 953.6423841059601, 954.2890546542818, 15578.688426231469, 15807.446739364124, 15852.524424267276, 15862.682746345066, 15880.761788573167, 13498.0, 14319.713605727879, 14595.051321664085, 14755.262236888166, 14756.926215368909, 897.6319708919344, 908.5865931001379, 914.1589737441569, 915.7756349694334, 916.8716379706847, 905.180811365715, 910.0171814440422, 910.3218102513637, 910.39003867409, 910.81328327693, 948.7201275623707, 954.6754103604773, 954.8233576788282, 955.073578628729, 955.2549011770795, 945.4185675809362, 945.8628498867695, 946.4747065378712, 946.7443790176683, 946.9715908522721, 692.9688164032581, 693.3551796828947, 695.2942763095463, 695.422799076765, 695.5826504097552, 13688.452461901612, 13718.0, 13745.862541374558, 13823.585292441243, 13830.654233644138, 13328.333583320893, 13343.132696374705, 13346.933265333708, 13454.596362109152, 13486.797698034537, 11369.022240290336, 11409.60066397672, 11582.131340149523, 11611.94194029033, 11826.172167948247, 3712.257548490286, 3738.869139580129, 3752.699784017272, 3824.7896365699876, 3908.1988192420486, 45202.77398613019, 48494.515054849355, 48622.10692152121, 55391.72304138494, 55577.0, 11871.821922671166, 12564.81152782709, 12599.0, 12697.682557936125, 12940.870591294155, 18933.90533047326, 21585.784142158376, 21753.67369489459, 22085.227017054327, 22117.115315387528, 9248.21390181842, 9296.95351523238, 9354.812903741888, 9448.95275523618, 9490.145886870216, 5013.666847563593, 5122.513361230752, 5150.4334523202415, 5243.68537887728, 5265.921011184835, 3600.2439487707875, 3625.1118475973026, 3669.3945498992903, 3681.7054635629083, 3684.097396137963, 673.441043933534, 675.7769935921134, 682.5529278322707, 687.4053943338976, 691.7959202035412, 664.9135612370458, 765.9731909383145, 773.3194788586121, 776.8990031296008, 791.7941335252875, 10089.0, 10169.338992965433, 10251.38491690501, 10351.534180961724, 10457.633982810565, 690.4821383962028, 710.1478226128667, 736.3520102309933, 745.9627018649046, 748.0425055928421, 4552.0, 4668.439787225555, 4747.691400058985, 4812.013537224861, 4890.731009794425, 65954.34045659578, 66704.66647666828, 67029.0, 68973.65513172402, 69334.30665693278, 53684.19473707898, 54095.72952135214, 54482.45517544853, 57542.42457575371, 59117.113243300526, 52630.210546842594, 53110.46889531132, 53305.2004219937, 53989.46010539923, 54238.72880635571, 9955.950220248853, 10343.689689309333, 10380.636677716244, 10401.739956501147, 10507.789844203226, 38696.226075478895, 39293.607063929, 39724.404133938595, 40065.399019014156, 40075.79962100171, 45473.0, 50616.24075638942, 51424.74287628538, 51525.0, 51752.223716645036, 11460.19778615489, 11814.763704725685, 12130.33283169434, 12178.269303841798, 12517.812232816697, 13797.655058623615, 13924.234167120905, 14268.0, 14755.926220368829, 15321.233938302817, 13709.314534273446, 13819.654508637364, 13914.304284785923, 13915.304234788422, 14199.361028753938, 13564.72870542564, 13753.106048106842, 13806.585802425943, 13898.444062237802, 13932.30338483092, 13232.867671323163, 13929.442822287401, 14634.121952682874, 14639.121652700873, 14645.633859153606, 10658.738103419977, 10827.783444330911, 10999.33857863509, 11270.267432616854, 11613.76772464563, 10301.0, 10504.474776261004, 10836.729081772703, 10987.230893837674, 11185.608503702331], "value": 7241.957775771894, "unit": "score"}], "name": "dromaeo_css", "value": 7423.784604626034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 111.0, 112.0, 113.0, 109.0, 112.0, 112.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 126.0, 155.0, 180.0, 127.0, 155.0, 162.0, 135.0, 193.0, 127.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 174.0, 74.0, 77.0, 76.0, 79.0, 160.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 157.0, 92.0, 92.0, 93.0, 151.0, 93.0, 92.0, 149.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 54.0, 55.0, 53.0, 75.0, 54.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 80.0, 75.0, 75.0, 73.0, 73.0, 76.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 111.0, 115.0, 121.0, 111.0, 111.0, 114.0, 135.0, 135.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 159.0, 157.0, 159.0, 162.0, 157.0, 156.0, 162.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1519.9, "alertThreshold": 2.0}]} 04:26:08 INFO - Return code: 0 04:26:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:08 ERROR - # TBPL SUCCESS # 04:26:08 INFO - Running post-action listener: _resource_record_post_action 04:26:08 INFO - Running post-run listener: _resource_record_post_run 04:26:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498761728; Read time: 20; Write time: 401124 04:26:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248582144; Read time: 0; Write time: 250304 04:26:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250179584; Read time: 20; Write time: 150820 04:26:09 INFO - Running post-run listener: _upload_blobber_files 04:26:09 INFO - Blob upload gear active. 04:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:09 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 04:26:09 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:09 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:10 INFO - (blobuploader) - INFO - Done attempting. 04:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:11 INFO - (blobuploader) - INFO - Done attempting. 04:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:11 INFO - Return code: 0 04:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f147ba23839c5747b758e7c7aa07a982185504305545f17c45cf7348a78c79e926edf6dbc0808502dfaa9ac3a2f8c05b08dfc01a3b47a54d691726b6dacf3aa1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb4cb15760b6000770fd6beb28709280219bdf1ba2a73094d2b346548e13ff8e3221858b1954cfc167d098cc2475323138f7fe50b65cd95476b7925b63d31023"} 04:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:11 INFO - Contents: 04:26:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f147ba23839c5747b758e7c7aa07a982185504305545f17c45cf7348a78c79e926edf6dbc0808502dfaa9ac3a2f8c05b08dfc01a3b47a54d691726b6dacf3aa1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb4cb15760b6000770fd6beb28709280219bdf1ba2a73094d2b346548e13ff8e3221858b1954cfc167d098cc2475323138f7fe50b65cd95476b7925b63d31023"} 04:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:11 INFO - Copying logs to upload dir... 04:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.268510 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-11 04:26:11.197472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:11.200891) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f147ba23839c5747b758e7c7aa07a982185504305545f17c45cf7348a78c79e926edf6dbc0808502dfaa9ac3a2f8c05b08dfc01a3b47a54d691726b6dacf3aa1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb4cb15760b6000770fd6beb28709280219bdf1ba2a73094d2b346548e13ff8e3221858b1954cfc167d098cc2475323138f7fe50b65cd95476b7925b63d31023"} build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f147ba23839c5747b758e7c7aa07a982185504305545f17c45cf7348a78c79e926edf6dbc0808502dfaa9ac3a2f8c05b08dfc01a3b47a54d691726b6dacf3aa1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb4cb15760b6000770fd6beb28709280219bdf1ba2a73094d2b346548e13ff8e3221858b1954cfc167d098cc2475323138f7fe50b65cd95476b7925b63d31023"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:11.225350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:11.225662) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462964700.314818-1104452257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:11.310300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:11.310654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:11.310919) ========= ========= Total master_lag: 0.17 =========