builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1462964633.73 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:53.729672) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:53.730145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:53.730421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:53.747379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:53.747792) ========= 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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:03:53-- 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% 58.6K=0.2s 2016-05-11 04:03:54 (58.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.334702 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.095803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.096147) ========= 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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014164 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.145575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.145970) ========= 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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:03:54,259 truncating revision to first 12 chars 2016-05-11 04:03:54,259 Setting DEBUG logging. 2016-05-11 04:03:54,259 attempt 1/10 2016-05-11 04:03:54,259 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:03:54,633 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.825113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.825422) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.825822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.826099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:03:54.836225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-11 04:03:54.836831) ========= /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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:03:55 INFO - MultiFileLogger online at 20160511 04:03:55 in /builds/slave/test 04:03:55 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:03:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:03:55 INFO - {'append_to_log': False, 04:03:55 INFO - 'base_work_dir': '/builds/slave/test', 04:03:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:03:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:03:55 INFO - 'branch': 'Mozilla-Aurora', 04:03:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:03:55 INFO - 'config_files': ('talos/linux_config.py',), 04:03:55 INFO - 'default_actions': ('clobber', 04:03:55 INFO - 'read-buildbot-config', 04:03:55 INFO - 'download-and-extract', 04:03:55 INFO - 'populate-webroot', 04:03:55 INFO - 'create-virtualenv', 04:03:55 INFO - 'install', 04:03:55 INFO - 'run-tests'), 04:03:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:03:55 INFO - 'download_minidump_stackwalk': True, 04:03:55 INFO - 'download_symbols': 'ondemand', 04:03:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:03:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:03:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:03:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:03:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:03:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:03:55 INFO - 'installer_path': 'installer.exe', 04:03:55 INFO - 'log_level': 'info', 04:03:55 INFO - 'log_name': 'talos', 04:03:55 INFO - 'log_to_console': True, 04:03:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:03:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:03:55 INFO - 'opt_config_files': (), 04:03:55 INFO - 'pip_index': False, 04:03:55 INFO - 'sps_profile': False, 04:03:55 INFO - 'sps_profile_interval': 0, 04:03:55 INFO - 'suite': 'dromaeojs', 04:03:55 INFO - 'system_bits': '32', 04:03:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:03:55 INFO - 'title': 'talos-linux64-ix-069', 04:03:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:03:55 INFO - 'use_talos_json': True, 04:03:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:03:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:03:55 INFO - 'work_dir': 'build'} 04:03:55 INFO - ##### 04:03:55 INFO - ##### Running clobber step. 04:03:55 INFO - ##### 04:03:55 INFO - Running pre-action listener: _resource_record_pre_action 04:03:55 INFO - Running main action method: clobber 04:03:55 INFO - rmtree: /builds/slave/test/build 04:03:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:03:55 INFO - Running post-action listener: _resource_record_post_action 04:03:55 INFO - ##### 04:03:55 INFO - ##### Running read-buildbot-config step. 04:03:55 INFO - ##### 04:03:55 INFO - Running pre-action listener: _resource_record_pre_action 04:03:55 INFO - Running main action method: read_buildbot_config 04:03:55 INFO - Using buildbot properties: 04:03:55 INFO - { 04:03:55 INFO - "project": "", 04:03:55 INFO - "product": "firefox", 04:03:55 INFO - "script_repo_revision": "production", 04:03:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:03:55 INFO - "repository": "", 04:03:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:03:55 INFO - "buildid": "20160510142413", 04:03:55 INFO - "pgo_build": "True", 04:03:55 INFO - "basedir": "/builds/slave/test", 04:03:55 INFO - "buildnumber": 496, 04:03:55 INFO - "slavename": "talos-linux64-ix-069", 04:03:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:03:56 INFO - "platform": "ubuntu64_hw", 04:03:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:03:56 INFO - "branch": "mozilla-aurora", 04:03:56 INFO - "repo_path": "releases/mozilla-aurora", 04:03:56 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 04:03:56 INFO - "stage_platform": "linux64-pgo", 04:03:56 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 04:03:56 INFO - "slavebuilddir": "test" 04:03:56 INFO - } 04:03:56 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:03:56 INFO - Running post-action listener: _resource_record_post_action 04:03:56 INFO - ##### 04:03:56 INFO - ##### Running download-and-extract step. 04:03:56 INFO - ##### 04:03:56 INFO - Running pre-action listener: _resource_record_pre_action 04:03:56 INFO - Running main action method: download_and_extract 04:03:56 INFO - mkdir: /builds/slave/test/build/tests 04:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:56 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:03:56 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:03:56 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:03:56 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:03:56 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:04:01 INFO - Downloaded 1361 bytes. 04:04:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:04:01 INFO - Using the following test package requirements: 04:04:01 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:01 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:01 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:04:01 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'jsshell-linux-x86_64.zip'], 04:04:01 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:01 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:01 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:04:01 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:04:01 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:01 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:01 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:01 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:08 INFO - Downloaded 23800226 bytes. 04:04:08 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:04:08 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:04:10 INFO - Return code: 0 04:04:10 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:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:10 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:04:10 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:04:10 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:04:10 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:04:10 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:04:11 INFO - Downloaded 23800226 bytes. 04:04:11 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:04:11 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:04:12 INFO - Return code: 0 04:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:13 INFO - Downloaded 10840145 bytes. 04:04:13 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:04:13 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:04:13 INFO - Return code: 0 04:04: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:04:13 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:04:13 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:04:13 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:04:13 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:04:13 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:04:15 INFO - Downloaded 62686755 bytes. 04:04:15 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:04:15 INFO - mkdir: /builds/slave/test/properties 04:04:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:15 INFO - Contents: 04:04:15 INFO - build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:15 INFO - Running post-action listener: _resource_record_post_action 04:04:15 INFO - Running post-action listener: set_extra_try_arguments 04:04:15 INFO - ##### 04:04:15 INFO - ##### Running populate-webroot step. 04:04:15 INFO - ##### 04:04:15 INFO - Running pre-action listener: _resource_record_pre_action 04:04:15 INFO - Running main action method: populate_webroot 04:04:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:15 INFO - '--tppagecycles', 04:04:15 INFO - '7'], 04:04:15 INFO - 'tests': ['tsvgm']}}, 04:04:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['damp', 'tps']}, 04:04:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'tests': ['damp', 'tps']}, 04:04:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['dromaeo_dom']}, 04:04:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['a11yr', 04:04:15 INFO - 'ts_paint', 04:04:15 INFO - 'tpaint', 04:04:15 INFO - 'sessionrestore', 04:04:15 INFO - 'sessionrestore_no_auto_restore', 04:04:15 INFO - 'tabpaint']}, 04:04:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['tsvgx', 04:04:15 INFO - 'tsvgr_opacity', 04:04:15 INFO - 'tart', 04:04:15 INFO - 'tscrollx', 04:04:15 INFO - 'cart']}, 04:04:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:15 INFO - 'tsvgr_opacity', 04:04:15 INFO - 'tart', 04:04:15 INFO - 'tscrollx', 04:04:15 INFO - 'cart']}, 04:04:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'talos_options': ['--disable-e10s'], 04:04:15 INFO - 'tests': ['tp5o']}, 04:04:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'tests': ['tp5o']}, 04:04:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'talos_options': ['--disable-e10s', 04:04:15 INFO - '--xperf_path', 04:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:15 INFO - 'tests': ['tp5n']}, 04:04:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:15 INFO - 'talos_options': ['--xperf_path', 04:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:15 INFO - 'tests': ['tp5n']}}, 04:04:15 INFO - 'talos.zip': {'path': '', 04:04:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:15 INFO - Running post-action listener: _resource_record_post_action 04:04:15 INFO - ##### 04:04:15 INFO - ##### Running create-virtualenv step. 04:04:15 INFO - ##### 04:04:15 INFO - Running pre-action listener: _resource_record_pre_action 04:04:15 INFO - Running main action method: create_virtualenv 04:04:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:15 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:04:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:15 INFO - Using real prefix '/usr' 04:04:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:18 INFO - Installing pip.................done. 04:04:18 INFO - Return code: 0 04:04:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:18 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:04:18 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:04:18 INFO - Using env: {'DISPLAY': ':0', 04:04:18 INFO - 'HOME': '/home/cltbld', 04:04:18 INFO - 'LANG': 'en_US.UTF-8', 04:04:18 INFO - 'LANGUAGE': 'en_US:en', 04:04:18 INFO - 'LOGNAME': 'cltbld', 04:04:18 INFO - 'MAIL': '/var/mail/cltbld', 04:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:18 INFO - 'MOZ_NO_REMOTE': '1', 04:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:18 INFO - 'NO_EM_RESTART': '1', 04:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:18 INFO - 'PWD': '/builds/slave/test', 04:04:18 INFO - 'SHELL': '/bin/bash', 04:04:18 INFO - 'SHLVL': '1', 04:04:18 INFO - 'TERM': 'linux', 04:04:18 INFO - 'TMOUT': '86400', 04:04:18 INFO - 'USER': 'cltbld', 04:04:18 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:18 INFO - '_': '/tools/buildbot/bin/python'} 04:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:18 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:04:18 INFO - Cleaning up... 04:04:18 INFO - Return code: 0 04:04:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:18 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:04:18 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:04:18 INFO - Using env: {'DISPLAY': ':0', 04:04:18 INFO - 'HOME': '/home/cltbld', 04:04:18 INFO - 'LANG': 'en_US.UTF-8', 04:04:18 INFO - 'LANGUAGE': 'en_US:en', 04:04:18 INFO - 'LOGNAME': 'cltbld', 04:04:18 INFO - 'MAIL': '/var/mail/cltbld', 04:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:18 INFO - 'MOZ_NO_REMOTE': '1', 04:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:18 INFO - 'NO_EM_RESTART': '1', 04:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:18 INFO - 'PWD': '/builds/slave/test', 04:04:18 INFO - 'SHELL': '/bin/bash', 04:04:18 INFO - 'SHLVL': '1', 04:04:18 INFO - 'TERM': 'linux', 04:04:18 INFO - 'TMOUT': '86400', 04:04:18 INFO - 'USER': 'cltbld', 04:04:18 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:18 INFO - '_': '/tools/buildbot/bin/python'} 04:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:18 INFO - Downloading/unpacking psutil>=0.7.1 04:04: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:04: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:04: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:04: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:04: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:04: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:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:20 INFO - Installing collected packages: psutil 04:04:20 INFO - Running setup.py install for psutil 04:04:20 INFO - building 'psutil._psutil_linux' extension 04:04:20 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:04:21 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:04:21 INFO - building 'psutil._psutil_posix' extension 04:04:21 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:04:21 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:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:21 INFO - Successfully installed psutil 04:04:21 INFO - Cleaning up... 04:04:21 INFO - Return code: 0 04:04:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:04:21 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:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:21 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:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:21 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:21 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:04:21 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:04:21 INFO - Using env: {'DISPLAY': ':0', 04:04:21 INFO - 'HOME': '/home/cltbld', 04:04:21 INFO - 'LANG': 'en_US.UTF-8', 04:04:21 INFO - 'LANGUAGE': 'en_US:en', 04:04:21 INFO - 'LOGNAME': 'cltbld', 04:04:21 INFO - 'MAIL': '/var/mail/cltbld', 04:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:21 INFO - 'MOZ_NO_REMOTE': '1', 04:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:21 INFO - 'NO_EM_RESTART': '1', 04:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:21 INFO - 'PWD': '/builds/slave/test', 04:04:21 INFO - 'SHELL': '/bin/bash', 04:04:21 INFO - 'SHLVL': '1', 04:04:21 INFO - 'TERM': 'linux', 04:04:21 INFO - 'TMOUT': '86400', 04:04:21 INFO - 'USER': 'cltbld', 04:04:21 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:21 INFO - '_': '/tools/buildbot/bin/python'} 04:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:24 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:04:24 INFO - Installing collected packages: mozsystemmonitor 04:04:24 INFO - Running setup.py install for mozsystemmonitor 04:04:25 INFO - Successfully installed mozsystemmonitor 04:04:25 INFO - Cleaning up... 04:04:25 INFO - Return code: 0 04:04:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04:25 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:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:25 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:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:25 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:25 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:04:25 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:04:25 INFO - Using env: {'DISPLAY': ':0', 04:04:25 INFO - 'HOME': '/home/cltbld', 04:04:25 INFO - 'LANG': 'en_US.UTF-8', 04:04:25 INFO - 'LANGUAGE': 'en_US:en', 04:04:25 INFO - 'LOGNAME': 'cltbld', 04:04:25 INFO - 'MAIL': '/var/mail/cltbld', 04:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:25 INFO - 'MOZ_NO_REMOTE': '1', 04:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:25 INFO - 'NO_EM_RESTART': '1', 04:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:25 INFO - 'PWD': '/builds/slave/test', 04:04:25 INFO - 'SHELL': '/bin/bash', 04:04:25 INFO - 'SHLVL': '1', 04:04:25 INFO - 'TERM': 'linux', 04:04:25 INFO - 'TMOUT': '86400', 04:04:25 INFO - 'USER': 'cltbld', 04:04:25 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:25 INFO - '_': '/tools/buildbot/bin/python'} 04:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:25 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:04:25 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:04:25 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:04:25 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:04:25 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:04:25 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:04:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04:27 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:04:27 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:04:27 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:04:27 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:04:27 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:04:27 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:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 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:04:28 INFO - Downloading docopt-0.6.1.tar.gz 04:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:28 INFO - Running setup.py install for blobuploader 04:04:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:28 INFO - Running setup.py install for requests 04:04:29 INFO - Running setup.py install for docopt 04:04:29 INFO - Successfully installed blobuploader requests docopt 04:04:29 INFO - Cleaning up... 04:04:29 INFO - Return code: 0 04:04:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:29 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:29 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:04:29 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:04:29 INFO - Using env: {'DISPLAY': ':0', 04:04:29 INFO - 'HOME': '/home/cltbld', 04:04:29 INFO - 'LANG': 'en_US.UTF-8', 04:04:29 INFO - 'LANGUAGE': 'en_US:en', 04:04:29 INFO - 'LOGNAME': 'cltbld', 04:04:29 INFO - 'MAIL': '/var/mail/cltbld', 04:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:29 INFO - 'MOZ_NO_REMOTE': '1', 04:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:29 INFO - 'NO_EM_RESTART': '1', 04:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:29 INFO - 'PWD': '/builds/slave/test', 04:04:29 INFO - 'SHELL': '/bin/bash', 04:04:29 INFO - 'SHLVL': '1', 04:04:29 INFO - 'TERM': 'linux', 04:04:29 INFO - 'TMOUT': '86400', 04:04:29 INFO - 'USER': 'cltbld', 04:04:29 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:29 INFO - '_': '/tools/buildbot/bin/python'} 04:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:29 INFO - Running setup.py (path:/tmp/pip-VIcRIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:29 INFO - Running setup.py (path:/tmp/pip-L0oZyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:29 INFO - Running setup.py (path:/tmp/pip-A2RBKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:29 INFO - Running setup.py (path:/tmp/pip-yJ6Zlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:29 INFO - Running setup.py (path:/tmp/pip-xkBGvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:29 INFO - Running setup.py (path:/tmp/pip-iFAY_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:29 INFO - Running setup.py (path:/tmp/pip-AeEhdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:29 INFO - Running setup.py (path:/tmp/pip-l7ji0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:29 INFO - Running setup.py (path:/tmp/pip-XbbRF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:30 INFO - Running setup.py (path:/tmp/pip-GXvM1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:30 INFO - Running setup.py (path:/tmp/pip-2zgFYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:30 INFO - Running setup.py (path:/tmp/pip-6DRjIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:30 INFO - Running setup.py (path:/tmp/pip-phO2JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:30 INFO - Running setup.py (path:/tmp/pip-qrHeS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:30 INFO - Running setup.py (path:/tmp/pip-VcsyxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:30 INFO - Running setup.py (path:/tmp/pip-2NCRVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:30 INFO - Running setup.py (path:/tmp/pip-FkksGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:30 INFO - Running setup.py install for manifestparser 04:04:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:30 INFO - Running setup.py install for mozcrash 04:04:30 INFO - Running setup.py install for mozdebug 04:04:30 INFO - Running setup.py install for mozdevice 04:04:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:04:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozfile 04:04:31 INFO - Running setup.py install for mozhttpd 04:04:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozinfo 04:04:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozInstall 04:04:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozleak 04:04:31 INFO - Running setup.py install for mozlog 04:04:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for moznetwork 04:04:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozprocess 04:04:31 INFO - Running setup.py install for mozprofile 04:04:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:31 INFO - Running setup.py install for mozrunner 04:04:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:32 INFO - Running setup.py install for mozscreenshot 04:04:32 INFO - Running setup.py install for moztest 04:04:32 INFO - Running setup.py install for mozversion 04:04:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:32 INFO - Cleaning up... 04:04:32 INFO - Return code: 0 04:04:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:32 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:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 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:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:32 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:04:32 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:04:32 INFO - Using env: {'DISPLAY': ':0', 04:04:32 INFO - 'HOME': '/home/cltbld', 04:04:32 INFO - 'LANG': 'en_US.UTF-8', 04:04:32 INFO - 'LANGUAGE': 'en_US:en', 04:04:32 INFO - 'LOGNAME': 'cltbld', 04:04:32 INFO - 'MAIL': '/var/mail/cltbld', 04:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:32 INFO - 'MOZ_NO_REMOTE': '1', 04:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:32 INFO - 'NO_EM_RESTART': '1', 04:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:32 INFO - 'PWD': '/builds/slave/test', 04:04:32 INFO - 'SHELL': '/bin/bash', 04:04:32 INFO - 'SHLVL': '1', 04:04:32 INFO - 'TERM': 'linux', 04:04:32 INFO - 'TMOUT': '86400', 04:04:32 INFO - 'USER': 'cltbld', 04:04:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:32 INFO - '_': '/tools/buildbot/bin/python'} 04:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:32 INFO - Running setup.py (path:/tmp/pip-xqGY_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:32 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:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:32 INFO - Running setup.py (path:/tmp/pip-YqSP_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:32 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:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:32 INFO - Running setup.py (path:/tmp/pip-48P2mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:32 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:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:32 INFO - Running setup.py (path:/tmp/pip-aqM0uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:32 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:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:32 INFO - Running setup.py (path:/tmp/pip-8MqYeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:32 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:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:32 INFO - Running setup.py (path:/tmp/pip-L9h1fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:33 INFO - Running setup.py (path:/tmp/pip-Hp6cU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:33 INFO - Running setup.py (path:/tmp/pip-GGdxhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:33 INFO - Running setup.py (path:/tmp/pip-CqFxeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:33 INFO - Running setup.py (path:/tmp/pip-2J1qgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:33 INFO - Running setup.py (path:/tmp/pip-UH0itM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:33 INFO - Running setup.py (path:/tmp/pip-HAr9PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:33 INFO - Running setup.py (path:/tmp/pip-X0LcGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:33 INFO - Running setup.py (path:/tmp/pip-186JnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:33 INFO - Running setup.py (path:/tmp/pip-25P1UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:33 INFO - Running setup.py (path:/tmp/pip-I2ChCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:33 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:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:33 INFO - Running setup.py (path:/tmp/pip-8yOEUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:33 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:04:33 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:04:33 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:04:33 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:04:33 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:04:33 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:04:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:35 INFO - Downloading blessings-1.6.tar.gz 04:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:35 INFO - Installing collected packages: blessings 04:04:35 INFO - Running setup.py install for blessings 04:04:35 INFO - Successfully installed blessings 04:04:35 INFO - Cleaning up... 04:04:35 INFO - Return code: 0 04:04:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:36 INFO - Reading from file tmpfile_stdout 04:04:36 INFO - Current package versions: 04:04:36 INFO - argparse == 1.2.1 04:04:36 INFO - blessings == 1.6 04:04:36 INFO - blobuploader == 1.2.4 04:04:36 INFO - docopt == 0.6.1 04:04:36 INFO - manifestparser == 1.1 04:04:36 INFO - mozInstall == 1.12 04:04:36 INFO - mozcrash == 0.17 04:04:36 INFO - mozdebug == 0.1 04:04:36 INFO - mozdevice == 0.48 04:04:36 INFO - mozfile == 1.2 04:04:36 INFO - mozhttpd == 0.7 04:04:36 INFO - mozinfo == 0.9 04:04:36 INFO - mozleak == 0.1 04:04:36 INFO - mozlog == 3.1 04:04:36 INFO - moznetwork == 0.27 04:04:36 INFO - mozprocess == 0.22 04:04:36 INFO - mozprofile == 0.28 04:04:36 INFO - mozrunner == 6.11 04:04:36 INFO - mozscreenshot == 0.1 04:04:36 INFO - mozsystemmonitor == 0.0 04:04:36 INFO - moztest == 0.7 04:04:36 INFO - mozversion == 1.4 04:04:36 INFO - psutil == 3.1.1 04:04:36 INFO - requests == 1.2.3 04:04:36 INFO - wsgiref == 0.1.2 04:04:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:36 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 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:36 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:04:36 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:04:36 INFO - Using env: {'DISPLAY': ':0', 04:04:36 INFO - 'HOME': '/home/cltbld', 04:04:36 INFO - 'LANG': 'en_US.UTF-8', 04:04:36 INFO - 'LANGUAGE': 'en_US:en', 04:04:36 INFO - 'LOGNAME': 'cltbld', 04:04:36 INFO - 'MAIL': '/var/mail/cltbld', 04:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:36 INFO - 'MOZ_NO_REMOTE': '1', 04:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:36 INFO - 'NO_EM_RESTART': '1', 04:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:36 INFO - 'PWD': '/builds/slave/test', 04:04:36 INFO - 'SHELL': '/bin/bash', 04:04:36 INFO - 'SHLVL': '1', 04:04:36 INFO - 'TERM': 'linux', 04:04:36 INFO - 'TMOUT': '86400', 04:04:36 INFO - 'USER': 'cltbld', 04:04:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:36 INFO - '_': '/tools/buildbot/bin/python'} 04:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 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:04:36 INFO - Cleaning up... 04:04:36 INFO - Return code: 0 04:04:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:04:36 INFO - Using env: {'DISPLAY': ':0', 04:04:36 INFO - 'HOME': '/home/cltbld', 04:04:36 INFO - 'LANG': 'en_US.UTF-8', 04:04:36 INFO - 'LANGUAGE': 'en_US:en', 04:04:36 INFO - 'LOGNAME': 'cltbld', 04:04:36 INFO - 'MAIL': '/var/mail/cltbld', 04:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:36 INFO - 'MOZ_NO_REMOTE': '1', 04:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:36 INFO - 'NO_EM_RESTART': '1', 04:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:36 INFO - 'PWD': '/builds/slave/test', 04:04:36 INFO - 'SHELL': '/bin/bash', 04:04:36 INFO - 'SHLVL': '1', 04:04:36 INFO - 'TERM': 'linux', 04:04:36 INFO - 'TMOUT': '86400', 04:04:36 INFO - 'USER': 'cltbld', 04:04:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:36 INFO - '_': '/tools/buildbot/bin/python'} 04:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:36 INFO - Downloading/unpacking jsonschema 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:38 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04:38 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:04:38 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:04:38 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:04:38 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:04:38 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:04:38 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:04:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:38 INFO - warning: no files found matching '*.txt' 04:04:38 INFO - no previously-included directories found matching 'build' 04:04:38 INFO - no previously-included directories found matching 'dist' 04:04:38 INFO - no previously-included directories found matching '.git*' 04:04:38 INFO - Installing collected packages: jsonschema, functools32 04:04:38 INFO - Running setup.py install for functools32 04:04:38 INFO - warning: no files found matching '*.txt' 04:04:38 INFO - no previously-included directories found matching 'build' 04:04:38 INFO - no previously-included directories found matching 'dist' 04:04:38 INFO - no previously-included directories found matching '.git*' 04:04:38 INFO - Successfully installed jsonschema functools32 04:04:38 INFO - Cleaning up... 04:04:38 INFO - Return code: 0 04:04:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4edf52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, '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': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', '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:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:04:38 INFO - Using env: {'DISPLAY': ':0', 04:04:38 INFO - 'HOME': '/home/cltbld', 04:04:38 INFO - 'LANG': 'en_US.UTF-8', 04:04:38 INFO - 'LANGUAGE': 'en_US:en', 04:04:38 INFO - 'LOGNAME': 'cltbld', 04:04:38 INFO - 'MAIL': '/var/mail/cltbld', 04:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:38 INFO - 'MOZ_NO_REMOTE': '1', 04:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:38 INFO - 'NO_EM_RESTART': '1', 04:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:38 INFO - 'PWD': '/builds/slave/test', 04:04:38 INFO - 'SHELL': '/bin/bash', 04:04:38 INFO - 'SHLVL': '1', 04:04:38 INFO - 'TERM': 'linux', 04:04:38 INFO - 'TMOUT': '86400', 04:04:38 INFO - 'USER': 'cltbld', 04:04:38 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:38 INFO - '_': '/tools/buildbot/bin/python'} 04:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:39 INFO - Downloading/unpacking flake8 04:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04:40 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:04:40 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:04:40 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:04:40 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:04:40 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:04:40 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:04:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:41 INFO - no previously-included directories found matching 'docs/_build' 04:04:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:04:41 INFO - Running setup.py install for pep8 04:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:41 INFO - no previously-included directories found matching 'docs/_build' 04:04:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:04:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:04:41 INFO - Cleaning up... 04:04:41 INFO - Return code: 0 04:04:41 INFO - Running post-action listener: _resource_record_post_action 04:04:41 INFO - Running post-action listener: _start_resource_monitoring 04:04:41 INFO - Starting resource monitoring. 04:04:41 INFO - ##### 04:04:41 INFO - ##### Running install step. 04:04:41 INFO - ##### 04:04:41 INFO - Running pre-action listener: _resource_record_pre_action 04:04:41 INFO - Running main action method: install 04:04:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:42 INFO - Reading from file tmpfile_stdout 04:04:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:04:42 INFO - Reading from file tmpfile_stdout 04:04:42 INFO - Output received: 04:04:42 INFO - Usage: mozinstall [options] installer 04:04:42 INFO - Options: 04:04:42 INFO - -h, --help show this help message and exit 04:04:42 INFO - -d DEST, --destination=DEST 04:04:42 INFO - Directory to install application into. [default: 04:04:42 INFO - "/builds/slave/test"] 04:04:42 INFO - --app=APP Application being installed. [default: firefox] 04:04:42 INFO - mkdir: /builds/slave/test/build/application 04:04:42 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:04:42 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:04:57 INFO - Reading from file tmpfile_stdout 04:04:57 INFO - Output received: 04:04:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:04:57 INFO - Running post-action listener: _resource_record_post_action 04:04:57 INFO - ##### 04:04:57 INFO - ##### Running run-tests step. 04:04:57 INFO - ##### 04:04:57 INFO - Running pre-action listener: _resource_record_pre_action 04:04:57 INFO - Running main action method: run_tests 04:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:04:57 INFO - Python 2.7.3 04:04:57 INFO - Return code: 0 04:04:57 INFO - grabbing minidump binary from tooltool 04:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:57 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 0x16bd410>, '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 0x16be310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16be7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:04:57 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:04:57 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:04:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:04:57 INFO - Return code: 0 04:04:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:04:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:04:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:04:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:04:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:04:58 INFO - Return code: 0 04:04:58 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-069', '--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:04:58 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-069 --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:04:58 INFO - Using env: {'DISPLAY': ':0', 04:04:58 INFO - 'HOME': '/home/cltbld', 04:04:58 INFO - 'LANG': 'en_US.UTF-8', 04:04:58 INFO - 'LANGUAGE': 'en_US:en', 04:04:58 INFO - 'LOGNAME': 'cltbld', 04:04:58 INFO - 'MAIL': '/var/mail/cltbld', 04:04:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:58 INFO - 'MOZ_NO_REMOTE': '1', 04:04:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:58 INFO - 'NO_EM_RESTART': '1', 04:04:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:58 INFO - 'PWD': '/builds/slave/test', 04:04:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:58 INFO - 'SHELL': '/bin/bash', 04:04:58 INFO - 'SHLVL': '1', 04:04:58 INFO - 'TERM': 'linux', 04:04:58 INFO - 'TMOUT': '86400', 04:04:58 INFO - 'USER': 'cltbld', 04:04:58 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1462964611.480260-616509049', 04:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:58 INFO - '_': '/tools/buildbot/bin/python'} 04:04:58 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-069', '--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:04:59 INFO - mozversion application_buildid: 20160510142413 04:04:59 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:04:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:04:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:04:59 INFO - mozversion application_name: Firefox 04:04:59 INFO - mozversion application_remotingname: firefox-dev 04:04:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:04:59 INFO - mozversion application_vendor: Mozilla 04:04:59 INFO - mozversion application_version: 48.0a2 04:04:59 INFO - mozversion platform_buildid: 20160510142413 04:04:59 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:04:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:04:59 INFO - mozversion platform_version: 48.0a2 04:04:59 INFO - using testdate: 1462964699 04:04:59 INFO - actual date: 1462964699 04:04:59 INFO - starting webserver on 'localhost:57535' 04:04:59 INFO - SUITE-START | Running 2 tests 04:04:59 INFO - TEST-START | dromaeo_css 04:04:59 INFO - operating with platform_type : linux_ 04:04:59 INFO - Initialising browser for dromaeo_css test... 04:04:59 INFO - TEST-INFO | started process 10845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps04Mwp/profile http://localhost:57535/getInfo.html) 04:05:04 INFO - PROCESS | 10845 | __metrics Screen width/height:1600/1200 04:05:04 INFO - PROCESS | 10845 | colorDepth:24 04:05:04 INFO - PROCESS | 10845 | Browser inner width/height: 1024/697 04:05:04 INFO - PROCESS | 10845 | __metrics 04:05:05 ERROR - PROCESS | 10845 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:05:06 INFO - TEST-INFO | 10845: exit 0 04:05:06 INFO - Browser initialized. 04:05:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:06 INFO - TEST-INFO | started process 10938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps04Mwp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:17 INFO - PROCESS | 10938 | RSS: Main: 141963264 04:05:17 INFO - PROCESS | 10938 | 04:06:09 INFO - PROCESS | 10938 | 1462964769537 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:08:16 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57535/tests/dromaeo/cssquery-ext.html) 04:08:17 INFO - PROCESS | 10938 | RSS: Main: 250675200 04:08:17 INFO - PROCESS | 10938 | 04:11:20 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-ext.html (next: http://localhost:57535/tests/dromaeo/cssquery-jquery.html) 04:11:20 INFO - PROCESS | 10938 | RSS: Main: 220008448 04:11:20 INFO - PROCESS | 10938 | 04:14:22 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57535/tests/dromaeo/cssquery-mootools.html) 04:14:23 INFO - PROCESS | 10938 | RSS: Main: 217821184 04:14:23 INFO - PROCESS | 10938 | 04:17:25 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57535/tests/dromaeo/cssquery-prototype.html) 04:17:25 INFO - PROCESS | 10938 | RSS: Main: 219762688 04:17:25 INFO - PROCESS | 10938 | 04:20:28 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57535/tests/dromaeo/cssquery-yui.html) 04:20:28 INFO - PROCESS | 10938 | RSS: Main: 181620736 04:20:28 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | Cycle 1(1): loaded http://localhost:57535/tests/dromaeo/cssquery-yui.html (next: http://localhost:57535/tests/dromaeo/cssquery-dojo.html) 04:23:31 INFO - PROCESS | 10938 | RSS: Main: 257609728 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | __start_tp_report 04:23:31 INFO - PROCESS | 10938 | _x_x_mozilla_page_load 04:23:31 INFO - PROCESS | 10938 | _x_x_mozilla_page_load_details 04:23:31 INFO - PROCESS | 10938 | |i|pagename|runs| 04:23:31 INFO - PROCESS | 10938 | |0;dojo.html;3291.7695761296713;3369.258763072123;3393.0838673558155;3394.117529442344;3414;5509.889802203954;5558.583106267031;5564.9721751391235;5576.665400075998;5585.888282234353;5552.694601796909;5603.131514615231;5608.831735047945;5616.297962754656;5672.035753921833;4893.119238537062;4983.601311895049;5136.537711605954;5189.351331083614;5209.765560549766;4939.876503087434;4954.207326827708;4982.103221420143;5076.898462030757;5089.6691715038405;5055.090083784918;5055.9241611375855;5110.872228194287;5112.36095488064;5133.768980395891;5027.547520723152;5050.065737838475;5074.568661663745;5088.84733457995;5115.693058416507;4928.1129396708575;4966.379202599675;5012.223105418666;5039.496050394968;5058.266551350033;5396.83809485716;5409.594280428983;5426.077566813651;5428.430014848463;5429.809956651498;5682.346530149044;5886.352501224862;5893.322267939199;5894.292684877799;5903.114532820068;5880.235569375996;5884.0585506318785;5916.053431450947;5929.8814023719715;5946.821595352103;5475.835724928259;5477.835664930059;5496.917546236809;5502.119660854284;5506.119020956668;5954.315253745788;5979.641221526722;6004.939950600526;6005.309389420186;6051.818445446644;5743.195952566644;5744.195812586241;5774.538036957033;5784.942150578525;5786.913196302059;5850.297964244318;5856.853578660568;5856.941430585724;5859.355470898197;5861.824145275648;5788.507976822018;5833;5836.649801011868;5838.737256823453;5881.05903055509;5851.912221316684;5884.529237660977;5884.617499862496;5888.823335299948;5915.852103697442;4473.575010374009;4497.2129877271345;4501.864944051684;4505.211587972158;4535.274356103007;3944.723869329177;3996.5603783583783;4027.4764280643913;4070.592940705965;4076.5311989121037;5603.859903502445;5606.21512988182;5608.635438696471;5620.381758006616;5623.522000629992;5915.822525324161;5922.1412895130825;5923.970380148158;5924.259467566554;5928.881422371528;5457.945420545744;5600.0759874620235;5650.26546548946;5691.516221121251;5695.60130790849;4746.762661866893;4751.883307422753;4755;4764.618830493552;4775.6657034007985;5941.970290148608;5993.760249589967;6053.576249662569;6054.485368743618;6064.393560643988;5893.557983151195;5965.821025369246;5971.641701497924;5974.014287642664;5995.430434108753;6053.606515576474;6070.848228794315;6096.268447786294;6099.725512352044;6103.938960610337;5699.287589051369;5794.797182098775;5795.304563452412;5795.623284486495;5823.796167134299;5885.352611212677;5896.911546326723;5899.321578018583;5903.793367232126;5926.348101708722;5752.165935939349;5754.251947246831;5756.0502517084215;5764.538836892954;5770.961226979184;5545.112781954868;5728.856778580569;5748.281464816898;5765.855853603525;5805.796797112081;5581.916271255853;5601.04782187021;5614.7192640367;5616.157576363578;5697.145428185805;5776.740046697824;5787.160861674949;5798.043322851851;5799.420057994335;5804.2744656917885;5573.303337082864;5728.255326807488;5743.9138412923;5765.250517432874;5804.82585522435 04:23:31 INFO - PROCESS | 10938 | |1;ext.html;656.4420242793626;674.3559900295219;678.4030053552876;728.7194430144394;751.0424209133357;32430;40246;40660.39009414861;40731.59268407315;40747.38878916815;43676.344854827206;44188.77905610467;44281.77859110708;44284;44424;8076.71731489398;8221.876671849897;8798.340124490673;8998.01021887592;10276.126529245023;10355.637552685657;10500.159987201005;10508.159347252202;10513;10514.631987880426;10651.25441219115;10733.83899241512;10738.08726258265;10740.355578665267;10741.194410419212;8281.875771863397;10707.625233116842;11014.724631884186;11020.834687479693;11026.173037022256;10427.582896684124;10522.105621022223;10548.472576371227;10549.578016879392;10554.788904221949;39584;40129;40327.193456131004;40430;40458.595414046074;3949.6050394960275;3962.623550762673;4011.919761604781;4367.847125350598;4374;34693;35216.471752923724;35303;35432.82283588591;35603;4447.488538818045;4454.22051141049;4507.256302710049;4525.683202175849;4566.634669226454;317578;318838;319063;320467;320754;39444.60555394467;66354;66798;66880.66559667171;66887;37669.81165094157;37943.4308485373;37949.620503794606;37973.05067373338;37979;15952.601184970237;17013.404530841362;17238.569035773955;17247.396341128002;17287.481375558753;14304.28478576067;14588.270586470633;14590.416383344547;14593.562193134223;14597.270136493133;9280.489573073546;9325.114114159143;9349.532523373804;9392.90607093934;9393.060693930689;3495.493153492729;3602.837872295753;3622.2936527377437;3623.148560088377;3643.4716966040305;1168.4917061078459;1211.6243964371074;1215.7568486302775;1241.9875801242054;1253.8996880249558;33387.49918751221;33740.49389259163;33797.49303760446;34220.82889585536;34890.30219395598;1211.6001719432743;1240.7270400511873;1245.2092920995053;1265.379963817741;1379.6206043338161;17964.261973032782;18048.36830710945;18128.9843442373;18429.81570184308;18434.539136521693;450633;459057;459807;460556;461245;63395;64542.35457645457;64857.67571162114;64895;64925.35074649193;1356.9525066622818;1498.887583431247;1519.901206421579;1521.9162946038296;1630.7390817469147;30040.058699876492;33461.330773384885;33650;34286.48570271398;34559.65440345564;51092;51137;51601.7419912913;51668.22497662613;51717.48282517127;287578;288545;288650;289146;289170;28143.326383993488;31270.374592507567;31860;31883.36233275275;31903;44351.55648443474;45305.54694453145;45451.77274113608;46375.072498550515;46555;40042.79978600088;41305.58694413138;41863.50919264637;42849.571504284555;42993;40875.26700114181;41654;42086;42482.36276455794;42806.57193428151;43778.78110609554;43946.560534395525;46441.30338044865;47046;47279;32995.83502082474;34715.30569388548;35164.64835351614;35200.647993519735;35665.64334356623;27193.86403068051;27254.318642034108;27267.954903381928;27314.317142071606;27700.307492312855 04:23:31 INFO - PROCESS | 10938 | |2;jquery.html;416.1593580966448;424.31896805626985;429.50177793759224;433.63574597338237;442.3939203291491;17416.738748918775;18557.907210463945;19264.422067337968;19270.51823704408;19282.32511862085;18544.907275463636;18837.52906177346;21212.787872121273;22047;22049.11803527861;6414;6466.773662921799;6735.461163106939;6740.730370785162;6745.932540674579;6582.670866456682;6622.701978410959;6666.966665166668;6670.399664030237;6681.699323530453;6708;6982.720691172347;6987.790366289019;6990;7000.299970002984;6884.690188941485;6914.723411063552;7177.533460325062;7177.7487787927175;7183.928160718378;6840.897386539206;6869.931300686979;6991.19601245853;6995.510314278003;7021.964890175567;25689.100881469247;25742.87128564364;25903.611445828326;26053;26089;2710.9593356099676;2901.390707951333;2934.5744866994164;2936.735693787548;3246.594175728034;15795.526134215992;16127.838721612869;16430.917845410815;16719.91640041792;17216.56958576033;2240.260713964388;2240.764719704424;2272.6477396003647;2289.5649826532904;2324.070371851256;91538.54230728804;92075;92484.53757731168;95278;95833.52083239608;17399.65200695979;18522.166502507418;18549;18787.248510059446;19017.809821901603;33799.98600042002;33891.83054084763;33986;34497.827510862284;34563.82718086393;10811.297265677706;10889.237753357347;11004.119670426348;11041.061509771598;11205.103591712643;9241.676541321021;9297.814043719087;9344.15902568772;9369.48467834262;9495.192908602847;9100.635974561075;9434.34898892691;9478.478683672327;9585.281103917234;9661.855072173923;3619.692326152254;3636.3272794533095;3638.472421498868;3772.3775577029483;3821.980890095532;1039.2465462539599;1112.7211224141558;1151.781161579314;1158.5655379232787;1187.9109066819851;17625.47123586269;18747.531311717044;18840.717389239173;19499.61000780005;19628.509287267934;1121.9102471802237;1122.644140733947;1124.2692250037378;1143.5425829668034;1191.1602320364295;10876.673699789018;11306.162716334567;11502.194846360675;11865;11978.58074967372;564907;567130;573933;579732;583780;95354.52322738481;98483.50758246164;98831;99493.50253248688;99875.50062249787;1103.2663278919429;1124.083871644607;1161.3844662329147;1165.7843298989715;1168.59099315239;17838.643227135643;17984.19071141828;18109.728354074963;18253.817461825744;18544.350947716764;37352.43971340486;39480.80259598684;39969.60030399775;40745.64449485153;41461.37807932823;58846.4115358858;59472;59487;59507.70246148742;59576;8626.137386261324;8727.825443490967;8956.462612243286;9084.227840633355;9206.17144457002;12908.612741617766;13644.044916855724;13692.52076177329;13745.518906838213;13919.373628186959;12015.339156346485;12103.818442723543;12172.939135304267;12233.69415764613;12310.81533777012;11559.479823407799;11604.361760103275;11736.823947640964;11776.352300623548;11928;12425.875741242833;12574.49702011946;12599.559015434783;12607.873921261036;12616.87383126157;8631.093735157718;8944.195022448012;9046.366754327133;9048.833475016405;9179.495127768037;8993.415427997159;11107.44462776874;11415.25800822977;11839.171258011856;12147.574834880737 04:23:31 INFO - PROCESS | 10938 | |3;mootools.html;1436.39671338038;1553.0836806284294;1569.8901076924612;1787.8301561351668;1889.0271510172263;7813.6483858226375;7961.442699011071;8003.6398362073705;8005.359571234288;8016.318612917895;7620.542767433958;7731.574763388011;7758.456908016441;7762.068551773781;7773.766786996385;2074.346580827042;2118.0892216346965;2118.523332250239;2361.8464799788003;2395.7724016218517;2346.2374728213313;2402.2793162051403;2402.8197885158684;2407.7712617301418;2408.2534414331612;2284.2804516577307;2310.4570425949973;2325.790678838904;2328.1734984080663;2371.9644205336936;2063.793620637939;2112.0812446585783;2310.0528783198893;2340.3330050935488;2344.835861489688;2059.8661087029295;2296.70142881426;2328.836981411302;2345.601247787863;2347.1784875293683;7865.68537258509;7899.842003159962;7906.130325664172;7919.089304729972;7924.207579242087;4991.425986011583;5079.79680812767;5103.4896510349035;5114.514121158484;5119.513646203604;3294.2093897464674;3349.480830471281;3371.3257348530146;3513.2622149348667;3556.3065202285566;1236.1655882279426;1247.382545639905;1259.703969567151;1268.1883594499527;1268.8540817805979;11373.203875728703;11377.2035957483;11432.085433165326;11432.599859004895;11433.085353171726;4498.6626003049905;4572.977135114304;4633.976830115827;4639.675222734376;4651.069806030527;9693.273004524688;9695.418274903528;9705.9029409705;9712.028797120372;9743.464109473905;5263.736813159403;5267.1309233976735;5274.973625131926;5275.947240527622;5278.340207474066;4185.162967406531;4645.3496510487885;4747.881302967385;4823.27650852375;4827.782749776268;3864.9227015460096;3910.1202229498135;3937.114149316381;3963.7027222958395;4003.339448990942;1312.4487715159655;1316.230005446805;1320.9273489958146;1327.5287273018132;1347.353270430199;966.6809952715587;1033.1166852341291;1041.9479026048666;1048.2976405808126;1092.229977865603;5881.882362352729;5950.434708702666;5959;6077.726502307407;6079.148919151322;484.6268373352499;497.19950879084644;508.105733908324;510.6961357991989;515.8555604430766;4096.5903409658795;4123.97938010308;4135.627793498599;4193.706440549132;4201.264778663722;9980.151687106532;10281;10415.218858585637;10431.791364172826;10453.477326133814;10144.188464922789;10278.074973252295;10292.536835842406;10298.536565854554;10305.587776489007;7458.552486850806;7940.841183176304;8069.959650201711;8108.2297181767635;8130.796730081795;5777.104548794943;5838.357780644211;5852.970735146297;5911.261092363455;6021.759129634941;8855.468671879707;8907.10928907104;8963.282937364866;9027.052159523419;9171.908280917105;9133.40632858862;9321.207697345802;9339.673111441067;9397.765055873659;9397.906020939703;6349.682515874096;6375.681215939092;6819.829504262235;7033.648317584202;7116.644167791694;7166.820829479305;7838.137804841577;7845.725399610987;7869.213078692314;7872.488288261245;6787.185537735306;7145.9285407147345;7148.571085734872;7276.381507571916;7337.119545654556;7132.643367831484;7139.2503787101605;7180.281971802778;7241.45689073311;7250.057492525938;6511.674416279262;6573.685262947525;6590.736370545316;6624.536282460182;6624.867502650017;5158.690478571298;5211.9478805211465;5237.3453318335205;5287.312649355559;5290.28581141541;5091.414487334004;5212.9739351304515;5228.1112210923475;5262.184361423985;5294.761735721979 04:23:31 INFO - PROCESS | 10938 | |4;prototype.html;356.5614294417866;356.6326683515979;360.5799243880879;363.0252771309037;368.27449923650414;6315.431611154995;6324.715387807542;6333.366663333664;6335.904961425582;6363.618182909028;5995.490383317423;6116.847078823032;6230.065490176465;6310.24277086749;6339.175907132067;4825.855224343275;4828.203346447832;4832.951670483285;4847.2002119650215;4849.102915960559;4874.8537543873745;4889.119958407486;4892.5596696297325;4894.461609222983;4905.411350637928;4624.537546245382;4712.787924543387;4797.184478638623;4856;4856.3201151838775;4821.397325334333;4825.348577941968;4839.637027222955;4861.052094841507;4862.6596138270515;4259.978700106511;4266.338717498793;4278.721883077621;4278.914421711548;4291.763952982585;6084.60450070744;6086.117512960596;6090.634561926298;6092.147099406086;6096.177016102858;5647.209390685307;5653.9151912721345;5658.801941932013;5659.60382773206;5667.773289068432;6390.456811171056;6637.369449902251;6645.867082658368;6673.432758215509;6676.86646267072;4579.267317229227;4590.127875703605;4604.102200070987;4606.424196975378;4617.561331673485;6915.861682766367;6983.266756990493;6992.755253566101;6994.825129371807;6995.195552511475;4689.695169813951;4694.131585656664;4703.247480403119;4706.1764191267075;4712.175369310357;4756.357891684647;4757.215059515211;4769.2369220925175;4771.06964141989;4773.66584339093;5312.521873031368;5471.85091130867;5533.806316778893;5542.140968149944;5545.9722701387045;6689.464842812563;6712.194536655535;6729.966350168218;6737.056812046318;6760.121184246115;1573.229117732326;1635.9856888729064;1636.1492024147376;1637.0341498515934;1639.7868277123898;1070.1492313610697;1089.7493576477295;1100.4827730966433;1106.3251416635846;1107.6732363952653;6369.840753981095;6454.515911306671;6458.12815269942;6464.385883341075;6468.029795530708;6777.830554236183;6780.084688567079;6797.0823938767635;6809.148856392951;6813.2846051163915;6456.967715161394;6463.547551671432;6464.705029714478;6470.12653291809;6470.22357317125;3659.9268014640093;3696.4270538066644;3699.9630003699617;3700.20445604191;3702.4631428442726;6982.162140543167;7085.716571337191;7127.572345659173;7133.82165445868;7161.641917904084;6918.169819621678;6944.409725173316;6960.408365289007;6970.163580370388;6971.407430368374;7121.074260346226;7123.465740069412;7135.5361901476235;7143.107111611049;7143.82140446493;6826.726930922708;6837.145356830396;6842.521023528305;6844.623545705034;6844.828879278058;6586;6744;6759.594424334556;6764.898526522008;6765.966170169315;7072.434205263669;7094.503384763017;7107.502474826712;7121.465890058163;7128.501004929813;4719.834805781781;4723.574878260973;4725.983913458623;4727.2436410174205;4730.858074257778;6803.897941530782;6810.523263371715;6812.8978065328065;6813.216480104653;6829.760958366433;6493.772717954849;6609.768658096944;6689.297623749436;6816.965915170393;6829.351211634887;6714.7314107437105;6753;6766.1204043476;6767.255601883888;6770.729170833111;6604.306547812603;6615.305392933673;6619.27188009309;6621.966890165519;6634.237062737847;6620.3710647488415;6788.76239331621;6812.931870681428;6827.385535301847;6835.316468353125;6604.933950660432;6635.734570617121;6636.634985075867;6639.966800165968;6646.2356828965285 04:23:31 INFO - PROCESS | 10938 | |5;yui.html;782.894309268249;842.974710758677;852.6163226548053;954.4368822394786;954.9236061115112;15170.772438413418;15359.616009599766;15403.537893863202;15414.15222162782;15420.383184672628;14193.21937293451;14208.431662733477;14220.502282420117;14228.644283892907;14267.71464570708;751.0424209133344;889.9199072083511;901.9143181397757;903.7559858838142;905.642271302835;892.5849479991803;899.0784445942928;899.4603238057146;900.5497251374313;903.5437104262338;948.0519480519481;949.1694767078806;951.7287573041684;952.1383148250844;958.8993155718654;784.2980532423478;931.4085555672129;948.6015873333216;951.0109486134412;951.3720944176845;695.9025736396909;699.1470406104544;700.4991431126718;701.0255744515129;701.2286484866656;15084.924575377163;15099.39602415913;15134.091954482656;15148.31832567526;15186.316615752317;15090.849091509053;15508.224588770629;15565.533034008999;15566.221688915623;15705.97911135784;11999.340036298001;12002.159848810586;12230.633081007583;12255.080868934776;12470.75058498825;3987.1228329767405;3999.580044095357;4018.1160144768105;4055.8580449684414;4131.669466442678;56033.71983140099;58689;58768.41231587672;59169.7041514794;59181.40818591802;11436.656900293005;11620.6513804586;11703.23928944616;11950.880491194977;11996.520139194334;19805.306814261432;20475.07862146207;20488.38534843957;20504.179832806818;20516.28193013267;8733.08302628215;8740.694075707319;8925.553722313858;9106.592606627568;9444.763880903032;5018.071656743514;5052.292679024939;5153.793848246103;5193;5262.815801446931;3615.6926661233565;3666.2484190740834;3668.79821609814;3669.6330366963625;3675.246574452231;579.5305802300151;673.7473447457204;699.3670727991176;712.056525104239;714.2536049827942;779.945403821727;817.4604760857806;824.4640983360863;824.6536454689045;828.3207769628847;9508.381955172892;9818.504333004754;9864.161546268504;9906.900930990741;9960.651377201762;687.9896801547981;785.7407055671615;794.8450052239758;806.9878951815728;810.8499927513429;4522.796474158671;4681.531846815359;4731.597814185764;4889.877753056131;4985.725785081783;61047.38952610417;62263.06605400923;62600.68699656564;65856;66448.33551664422;50986.49013509892;51685.22472162921;51774.22338664923;52949.47050529523;53027.469725303024;47480.525194748305;47752.522474775506;47845.28232076522;48141.5185848144;48644.513554863996;9681.806363872542;9730.270229732656;9747.853782193131;9763.316567840184;9843.852342215016;37738.245235095696;38352.42471362876;38841.805790970866;39242.41136382899;39411;45997.310040350094;46034.079318414115;49601.75199123981;50592;51452.22821657753;12617.306048167438;12619.873801262238;12674;12820.166689165175;12864.22814631125;14430.350634221275;14574.489892853699;14685.33915973805;14843.777343340074;15549;13759.449622015007;14018;14323.283835807959;14418.783718244444;14907.776383354476;13058.869411305765;13108.344582771015;13202.273874936971;13365.131266467648;13577.728445431234;13121;13144.868551314747;13300.201987880759;14331.785023224451;14370.3533341002;10386.792264154523;10437.843432348369;10635.94682026585;10720.571177152826;10775.541749650612;11361.261518001304;11441.427928603704;11740.236884602473;11749.412529373669;11883.227590206609 04:23:31 INFO - PROCESS | 10938 | __end_tp_report 04:23:31 INFO - PROCESS | 10938 | __start_cc_report 04:23:31 INFO - PROCESS | 10938 | _x_x_mozilla_cycle_collect,946 04:23:31 INFO - PROCESS | 10938 | __end_cc_report 04:23:31 INFO - PROCESS | 10938 | __startTimestamp1462965811300__endTimestamp 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | ------- Summary: start ------- 04:23:31 INFO - PROCESS | 10938 | Number of tests: 6 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#0] dojo.html Cycles:165 Average:5473.42 Median:5697.15 stddev:601.73 (10.6%) stddev-sans-first:578.73 04:23:31 INFO - PROCESS | 10938 | Values: 3291.8 3369.3 3393.1 3394.1 3414.0 5509.9 5558.6 5565.0 5576.7 5585.9 5552.7 5603.1 5608.8 5616.3 5672.0 4893.1 4983.6 5136.5 5189.4 5209.8 4939.9 4954.2 4982.1 5076.9 5089.7 5055.1 5055.9 5110.9 5112.4 5133.8 5027.5 5050.1 5074.6 5088.8 5115.7 4928.1 4966.4 5012.2 5039.5 5058.3 5396.8 5409.6 5426.1 5428.4 5429.8 5682.3 5886.4 5893.3 5894.3 5903.1 5880.2 5884.1 5916.1 5929.9 5946.8 5475.8 5477.8 5496.9 5502.1 5506.1 5954.3 5979.6 6004.9 6005.3 6051.8 5743.2 5744.2 5774.5 5784.9 5786.9 5850.3 5856.9 5856.9 5859.4 5861.8 5788.5 5833.0 5836.6 5838.7 5881.1 5851.9 5884.5 5884.6 5888.8 5915.9 4473.6 4497.2 4501.9 4505.2 4535.3 3944.7 3996.6 4027.5 4070.6 4076.5 5603.9 5606.2 5608.6 5620.4 5623.5 5915.8 5922.1 5924.0 5924.3 5928.9 5457.9 5600.1 5650.3 5691.5 5695.6 4746.8 4751.9 4755.0 4764.6 4775.7 5942.0 5993.8 6053.6 6054.5 6064.4 5893.6 5965.8 5971.6 5974.0 5995.4 6053.6 6070.8 6096.3 6099.7 6103.9 5699.3 5794.8 5795.3 5795.6 5823.8 5885.4 5896.9 5899.3 5903.8 5926.3 5752.2 5754.3 5756.1 5764.5 5771.0 5545.1 5728.9 5748.3 5765.9 5805.8 5581.9 5601.0 5614.7 5616.2 5697.1 5776.7 5787.2 5798.0 5799.4 5804.3 5573.3 5728.3 5743.9 5765.3 5804.8 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#1] ext.html Cycles:180 Average:52841.61 Median:35634.32 stddev:95659.63 (268.4%) stddev-sans-first:95847.73 04:23:31 INFO - PROCESS | 10938 | Values: 656.4 674.4 678.4 728.7 751.0 32430.0 40246.0 40660.4 40731.6 40747.4 43676.3 44188.8 44281.8 44284.0 44424.0 8076.7 8221.9 8798.3 8998.0 10276.1 10355.6 10500.2 10508.2 10513.0 10514.6 10651.3 10733.8 10738.1 10740.4 10741.2 8281.9 10707.6 11014.7 11020.8 11026.2 10427.6 10522.1 10548.5 10549.6 10554.8 39584.0 40129.0 40327.2 40430.0 40458.6 3949.6 3962.6 4011.9 4367.8 4374.0 34693.0 35216.5 35303.0 35432.8 35603.0 4447.5 4454.2 4507.3 4525.7 4566.6 317578.0 318838.0 319063.0 320467.0 320754.0 39444.6 66354.0 66798.0 66880.7 66887.0 37669.8 37943.4 37949.6 37973.1 37979.0 15952.6 17013.4 17238.6 17247.4 17287.5 14304.3 14588.3 14590.4 14593.6 14597.3 9280.5 9325.1 9349.5 9392.9 9393.1 3495.5 3602.8 3622.3 3623.1 3643.5 1168.5 1211.6 1215.8 1242.0 1253.9 33387.5 33740.5 33797.5 34220.8 34890.3 1211.6 1240.7 1245.2 1265.4 1379.6 17964.3 18048.4 18129.0 18429.8 18434.5 450633.0 459057.0 459807.0 460556.0 461245.0 63395.0 64542.4 64857.7 64895.0 64925.4 1357.0 1498.9 1519.9 1521.9 1630.7 30040.1 33461.3 33650.0 34286.5 34559.7 51092.0 51137.0 51601.7 51668.2 51717.5 287578.0 288545.0 288650.0 289146.0 289170.0 28143.3 31270.4 31860.0 31883.4 31903.0 44351.6 45305.5 45451.8 46375.1 46555.0 40042.8 41305.6 41863.5 42849.6 42993.0 40875.3 41654.0 42086.0 42482.4 42806.6 43778.8 43946.6 46441.3 47046.0 47279.0 32995.8 34715.3 35164.6 35200.6 35665.6 27193.9 27254.3 27268.0 27314.3 27700.3 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#2] jquery.html Cycles:180 Average:33430.28 Median:2917.98 stddev:94281.85 (3231.1%) stddev-sans-first:94513.75 04:23:31 INFO - PROCESS | 10938 | Values: 416.2 424.3 429.5 433.6 442.4 17416.7 18557.9 19264.4 19270.5 19282.3 18544.9 18837.5 21212.8 22047.0 22049.1 6414.0 6466.8 6735.5 6740.7 6745.9 6582.7 6622.7 6667.0 6670.4 6681.7 6708.0 6982.7 6987.8 6990.0 7000.3 6884.7 6914.7 7177.5 7177.7 7183.9 6840.9 6869.9 6991.2 6995.5 7022.0 25689.1 25742.9 25903.6 26053.0 26089.0 2711.0 2901.4 2934.6 2936.7 3246.6 15795.5 16127.8 16430.9 16719.9 17216.6 2240.3 2240.8 2272.6 2289.6 2324.1 91538.5 92075.0 92484.5 95278.0 95833.5 17399.7 18522.2 18549.0 18787.2 19017.8 33800.0 33891.8 33986.0 34497.8 34563.8 10811.3 10889.2 11004.1 11041.1 11205.1 9241.7 9297.8 9344.2 9369.5 9495.2 9100.6 9434.3 9478.5 9585.3 9661.9 3619.7 3636.3 3638.5 3772.4 3822.0 1039.2 1112.7 1151.8 1158.6 1187.9 17625.5 18747.5 18840.7 19499.6 19628.5 1121.9 1122.6 1124.3 1143.5 1191.2 10876.7 11306.2 11502.2 11865.0 11978.6 564907.0 567130.0 573933.0 579732.0 583780.0 95354.5 98483.5 98831.0 99493.5 99875.5 1103.3 1124.1 1161.4 1165.8 1168.6 17838.6 17984.2 18109.7 18253.8 18544.4 37352.4 39480.8 39969.6 40745.6 41461.4 58846.4 59472.0 59487.0 59507.7 59576.0 8626.1 8727.8 8956.5 9084.2 9206.2 12908.6 13644.0 13692.5 13745.5 13919.4 12015.3 12103.8 12172.9 12233.7 12310.8 11559.5 11604.4 11736.8 11776.4 11928.0 12425.9 12574.5 12599.6 12607.9 12616.9 8631.1 8944.2 9046.4 9048.8 9179.5 8993.4 11107.4 11415.3 11839.2 12147.6 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#3] mootools.html Cycles:180 Average:5487.20 Median:5109.00 stddev:2986.72 (58.5%) stddev-sans-first:2979.58 04:23:31 INFO - PROCESS | 10938 | Values: 1436.4 1553.1 1569.9 1787.8 1889.0 7813.6 7961.4 8003.6 8005.4 8016.3 7620.5 7731.6 7758.5 7762.1 7773.8 2074.3 2118.1 2118.5 2361.8 2395.8 2346.2 2402.3 2402.8 2407.8 2408.3 2284.3 2310.5 2325.8 2328.2 2372.0 2063.8 2112.1 2310.1 2340.3 2344.8 2059.9 2296.7 2328.8 2345.6 2347.2 7865.7 7899.8 7906.1 7919.1 7924.2 4991.4 5079.8 5103.5 5114.5 5119.5 3294.2 3349.5 3371.3 3513.3 3556.3 1236.2 1247.4 1259.7 1268.2 1268.9 11373.2 11377.2 11432.1 11432.6 11433.1 4498.7 4573.0 4634.0 4639.7 4651.1 9693.3 9695.4 9705.9 9712.0 9743.5 5263.7 5267.1 5275.0 5275.9 5278.3 4185.2 4645.3 4747.9 4823.3 4827.8 3864.9 3910.1 3937.1 3963.7 4003.3 1312.4 1316.2 1320.9 1327.5 1347.4 966.7 1033.1 1041.9 1048.3 1092.2 5881.9 5950.4 5959.0 6077.7 6079.1 484.6 497.2 508.1 510.7 515.9 4096.6 4124.0 4135.6 4193.7 4201.3 9980.2 10281.0 10415.2 10431.8 10453.5 10144.2 10278.1 10292.5 10298.5 10305.6 7458.6 7940.8 8070.0 8108.2 8130.8 5777.1 5838.4 5853.0 5911.3 6021.8 8855.5 8907.1 8963.3 9027.1 9171.9 9133.4 9321.2 9339.7 9397.8 9397.9 6349.7 6375.7 6819.8 7033.6 7116.6 7166.8 7838.1 7845.7 7869.2 7872.5 6787.2 7145.9 7148.6 7276.4 7337.1 7132.6 7139.3 7180.3 7241.5 7250.1 6511.7 6573.7 6590.7 6624.5 6624.9 5158.7 5211.9 5237.3 5287.3 5290.3 5091.4 5213.0 5228.1 5262.2 5294.8 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#4] prototype.html Cycles:180 Average:5585.78 Median:6380.15 stddev:1686.49 (26.4%) stddev-sans-first:1644.92 04:23:31 INFO - PROCESS | 10938 | Values: 356.6 356.6 360.6 363.0 368.3 6315.4 6324.7 6333.4 6335.9 6363.6 5995.5 6116.8 6230.1 6310.2 6339.2 4825.9 4828.2 4833.0 4847.2 4849.1 4874.9 4889.1 4892.6 4894.5 4905.4 4624.5 4712.8 4797.2 4856.0 4856.3 4821.4 4825.3 4839.6 4861.1 4862.7 4260.0 4266.3 4278.7 4278.9 4291.8 6084.6 6086.1 6090.6 6092.1 6096.2 5647.2 5653.9 5658.8 5659.6 5667.8 6390.5 6637.4 6645.9 6673.4 6676.9 4579.3 4590.1 4604.1 4606.4 4617.6 6915.9 6983.3 6992.8 6994.8 6995.2 4689.7 4694.1 4703.2 4706.2 4712.2 4756.4 4757.2 4769.2 4771.1 4773.7 5312.5 5471.9 5533.8 5542.1 5546.0 6689.5 6712.2 6730.0 6737.1 6760.1 1573.2 1636.0 1636.1 1637.0 1639.8 1070.1 1089.7 1100.5 1106.3 1107.7 6369.8 6454.5 6458.1 6464.4 6468.0 6777.8 6780.1 6797.1 6809.1 6813.3 6457.0 6463.5 6464.7 6470.1 6470.2 3659.9 3696.4 3700.0 3700.2 3702.5 6982.2 7085.7 7127.6 7133.8 7161.6 6918.2 6944.4 6960.4 6970.2 6971.4 7121.1 7123.5 7135.5 7143.1 7143.8 6826.7 6837.1 6842.5 6844.6 6844.8 6586.0 6744.0 6759.6 6764.9 6766.0 7072.4 7094.5 7107.5 7121.5 7128.5 4719.8 4723.6 4726.0 4727.2 4730.9 6803.9 6810.5 6812.9 6813.2 6829.8 6493.8 6609.8 6689.3 6817.0 6829.4 6714.7 6753.0 6766.1 6767.3 6770.7 6604.3 6615.3 6619.3 6622.0 6634.2 6620.4 6788.8 6812.9 6827.4 6835.3 6604.9 6635.7 6636.6 6640.0 6646.2 04:23:31 INFO - PROCESS | 10938 | 04:23:31 INFO - PROCESS | 10938 | [#5] yui.html Cycles:180 Average:15516.75 Median:47616.52 stddev:17410.36 (36.6%) stddev-sans-first:17424.04 04:23:31 INFO - PROCESS | 10938 | Values: 782.9 843.0 852.6 954.4 954.9 15170.8 15359.6 15403.5 15414.2 15420.4 14193.2 14208.4 14220.5 14228.6 14267.7 751.0 889.9 901.9 903.8 905.6 892.6 899.1 899.5 900.5 903.5 948.1 949.2 951.7 952.1 958.9 784.3 931.4 948.6 951.0 951.4 695.9 699.1 700.5 701.0 701.2 15084.9 15099.4 15134.1 15148.3 15186.3 15090.8 15508.2 15565.5 15566.2 15706.0 11999.3 12002.2 12230.6 12255.1 12470.8 3987.1 3999.6 4018.1 4055.9 4131.7 56033.7 58689.0 58768.4 59169.7 59181.4 11436.7 11620.7 11703.2 11950.9 11996.5 19805.3 20475.1 20488.4 20504.2 20516.3 8733.1 8740.7 8925.6 9106.6 9444.8 5018.1 5052.3 5153.8 5193.0 5262.8 3615.7 3666.2 3668.8 3669.6 3675.2 579.5 673.7 699.4 712.1 714.3 779.9 817.5 824.5 824.7 828.3 9508.4 9818.5 9864.2 9906.9 9960.7 688.0 785.7 794.8 807.0 810.8 4522.8 4681.5 4731.6 4889.9 4985.7 61047.4 62263.1 62600.7 65856.0 66448.3 50986.5 51685.2 51774.2 52949.5 53027.5 47480.5 47752.5 47845.3 48141.5 48644.5 9681.8 9730.3 9747.9 9763.3 9843.9 37738.2 38352.4 38841.8 39242.4 39411.0 45997.3 46034.1 49601.8 50592.0 51452.2 12617.3 12619.9 12674.0 12820.2 12864.2 14430.4 14574.5 14685.3 14843.8 15549.0 13759.4 14018.0 14323.3 14418.8 14907.8 13058.9 13108.3 13202.3 13365.1 13577.7 13121.0 13144.9 13300.2 14331.8 14370.4 10386.8 10437.8 10635.9 10720.6 10775.5 11361.3 11441.4 11740.2 11749.4 11883.2 04:23:31 INFO - PROCESS | 10938 | -------- Summary: end -------- 04:23:31 INFO - PROCESS | 10938 | 04:23:32 INFO - TEST-INFO | 10938: exit 0 04:23:32 INFO - TEST-OK | dromaeo_css | took 1113009ms 04:23:32 INFO - TEST-START | kraken 04:23:32 INFO - operating with platform_type : linux_ 04:23:32 INFO - Initialising browser for kraken test... 04:23:32 INFO - TEST-INFO | started process 11135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpom1MYT/profile http://localhost:57535/getInfo.html) 04:23:36 INFO - PROCESS | 11135 | __metrics Screen width/height:1600/1200 04:23:36 INFO - PROCESS | 11135 | colorDepth:24 04:23:36 INFO - PROCESS | 11135 | Browser inner width/height: 1024/697 04:23:36 INFO - PROCESS | 11135 | __metrics 04:23:37 ERROR - PROCESS | 11135 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:23:38 INFO - TEST-INFO | 11135: exit 0 04:23:38 INFO - Browser initialized. 04:23:38 INFO - Running cycle 1/1 for kraken test... 04:23:38 INFO - TEST-INFO | started process 11225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpom1MYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:50 INFO - PROCESS | 11225 | RSS: Main: 141815808 04:23:50 INFO - PROCESS | 11225 | 04:23:52 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57535/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:53 INFO - PROCESS | 11225 | RSS: Main: 196648960 04:23:53 INFO - PROCESS | 11225 | 04:23:56 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57535/tests/kraken/driver.html?testName=audio-dft) 04:23:56 INFO - PROCESS | 11225 | RSS: Main: 181932032 04:23:56 INFO - PROCESS | 11225 | 04:23:59 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57535/tests/kraken/driver.html?testName=audio-fft) 04:24:00 INFO - PROCESS | 11225 | RSS: Main: 272306176 04:24:00 INFO - PROCESS | 11225 | 04:24:02 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57535/tests/kraken/driver.html?testName=audio-oscillator) 04:24:02 INFO - PROCESS | 11225 | RSS: Main: 178892800 04:24:02 INFO - PROCESS | 11225 | 04:24:04 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57535/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:05 INFO - PROCESS | 11225 | RSS: Main: 176926720 04:24:05 INFO - PROCESS | 11225 | 04:24:08 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57535/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:09 INFO - PROCESS | 11225 | RSS: Main: 211857408 04:24:09 INFO - PROCESS | 11225 | 04:24:12 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57535/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:13 INFO - PROCESS | 11225 | RSS: Main: 212426752 04:24:13 INFO - PROCESS | 11225 | 04:24:15 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57535/tests/kraken/driver.html?testName=json-parse-financial) 04:24:16 INFO - PROCESS | 11225 | RSS: Main: 212529152 04:24:16 INFO - PROCESS | 11225 | 04:24:17 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57535/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:18 INFO - PROCESS | 11225 | RSS: Main: 192454656 04:24:18 INFO - PROCESS | 11225 | 04:24:20 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:20 INFO - PROCESS | 11225 | RSS: Main: 195899392 04:24:20 INFO - PROCESS | 11225 | 04:24:22 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:23 INFO - PROCESS | 11225 | RSS: Main: 209563648 04:24:23 INFO - PROCESS | 11225 | 04:24:25 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:26 INFO - PROCESS | 11225 | RSS: Main: 214663168 04:24:26 INFO - PROCESS | 11225 | 04:24:29 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:29 INFO - PROCESS | 11225 | RSS: Main: 211812352 04:24:29 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | Cycle 1(1): loaded http://localhost:57535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57535/tests/kraken/driver.html?testName=ai-astar) 04:24:31 INFO - PROCESS | 11225 | RSS: Main: 276013056 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | __start_tp_report 04:24:31 INFO - PROCESS | 11225 | _x_x_mozilla_page_load 04:24:31 INFO - PROCESS | 11225 | _x_x_mozilla_page_load_details 04:24:31 INFO - PROCESS | 11225 | |i|pagename|runs| 04:24:31 INFO - PROCESS | 11225 | |0;ai-astar;112;111;111;111;112;113;107;111;111;110 04:24:31 INFO - PROCESS | 11225 | |1;audio-beat-detection;152;125;162;188;128;152;151;126;186;128 04:24:31 INFO - PROCESS | 11225 | |2;audio-dft;160;161;161;162;160;161;161;161;158;157 04:24:31 INFO - PROCESS | 11225 | |3;audio-fft;77;76;74;169;77;76;76;79;171;74 04:24:31 INFO - PROCESS | 11225 | |4;audio-oscillator;93;93;149;93;93;93;143;92;93;150 04:24:31 INFO - PROCESS | 11225 | |5;imaging-gaussian-blur;116;117;116;116;116;118;116;117;117;117 04:24:31 INFO - PROCESS | 11225 | |6;imaging-darkroom;145;145;145;145;145;145;144;145;155;144 04:24:31 INFO - PROCESS | 11225 | |7;imaging-desaturate;95;95;95;95;95;94;96;95;95;95 04:24:31 INFO - PROCESS | 11225 | |8;json-parse-financial;53;54;54;54;53;55;54;74;55;52 04:24:31 INFO - PROCESS | 11225 | |9;json-stringify-tinderbox;58;66;58;57;57;57;58;58;58;57 04:24:31 INFO - PROCESS | 11225 | |10;stanford-crypto-aes;73;72;73;71;74;72;75;73;81;73 04:24:31 INFO - PROCESS | 11225 | |11;stanford-crypto-ccm;123;127;119;112;121;114;113;111;128;130 04:24:31 INFO - PROCESS | 11225 | |12;stanford-crypto-pbkdf2;159;155;156;160;159;161;155;162;154;156 04:24:31 INFO - PROCESS | 11225 | |13;stanford-crypto-sha256-iterative;67;66;67;66;65;66;69;65;65;65 04:24:31 INFO - PROCESS | 11225 | __end_tp_report 04:24:31 INFO - PROCESS | 11225 | __start_cc_report 04:24:31 INFO - PROCESS | 11225 | _x_x_mozilla_cycle_collect,1594 04:24:31 INFO - PROCESS | 11225 | __end_cc_report 04:24:31 INFO - PROCESS | 11225 | __startTimestamp1462965871622__endTimestamp 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | ------- Summary: start ------- 04:24:31 INFO - PROCESS | 11225 | Number of tests: 14 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.60 (1.4%) stddev-sans-first:1.64 04:24:31 INFO - PROCESS | 11225 | Values: 112.0 111.0 111.0 111.0 112.0 113.0 107.0 111.0 111.0 110.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.00 stddev:23.71 (15.6%) stddev-sans-first:25.14 04:24:31 INFO - PROCESS | 11225 | Values: 152.0 125.0 162.0 188.0 128.0 152.0 151.0 126.0 186.0 128.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 04:24:31 INFO - PROCESS | 11225 | Values: 160.0 161.0 161.0 162.0 160.0 161.0 161.0 161.0 158.0 157.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.61 (52.1%) stddev-sans-first:41.48 04:24:31 INFO - PROCESS | 11225 | Values: 77.0 76.0 74.0 169.0 77.0 76.0 76.0 79.0 171.0 74.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:26.38 (28.4%) stddev-sans-first:27.32 04:24:31 INFO - PROCESS | 11225 | Values: 93.0 93.0 149.0 93.0 93.0 93.0 143.0 92.0 93.0 150.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:24:31 INFO - PROCESS | 11225 | Values: 116.0 117.0 116.0 116.0 116.0 118.0 116.0 117.0 117.0 117.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.00 stddev:3.26 (2.2%) stddev-sans-first:3.44 04:24:31 INFO - PROCESS | 11225 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 155.0 144.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:24:31 INFO - PROCESS | 11225 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.00 stddev:6.46 (12.0%) stddev-sans-first:6.77 04:24:31 INFO - PROCESS | 11225 | Values: 53.0 54.0 54.0 54.0 53.0 55.0 54.0 74.0 55.0 52.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:2.72 (4.7%) stddev-sans-first:2.88 04:24:31 INFO - PROCESS | 11225 | Values: 58.0 66.0 58.0 57.0 57.0 57.0 58.0 58.0 58.0 57.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.00 stddev:2.79 (3.8%) stddev-sans-first:2.95 04:24:31 INFO - PROCESS | 11225 | Values: 73.0 72.0 73.0 71.0 74.0 72.0 75.0 73.0 81.0 73.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:122.00 stddev:7.10 (5.8%) stddev-sans-first:7.43 04:24:31 INFO - PROCESS | 11225 | Values: 123.0 127.0 119.0 112.0 121.0 114.0 113.0 111.0 128.0 130.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:159.00 stddev:2.83 (1.8%) stddev-sans-first:2.96 04:24:31 INFO - PROCESS | 11225 | Values: 159.0 155.0 156.0 160.0 159.0 161.0 155.0 162.0 154.0 156.0 04:24:31 INFO - PROCESS | 11225 | 04:24:31 INFO - PROCESS | 11225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 04:24:31 INFO - PROCESS | 11225 | Values: 67.0 66.0 67.0 66.0 65.0 66.0 69.0 65.0 65.0 65.0 04:24:31 INFO - PROCESS | 11225 | -------- Summary: end -------- 04:24:31 INFO - PROCESS | 11225 | 04:24:32 INFO - TEST-INFO | 11225: exit 0 04:24:32 INFO - TEST-OK | kraken | took 60584ms 04:24:32 INFO - SUITE-END | took 1173s 04:24:32 INFO - Completed test suite (00:19:33) 04:24:32 INFO - javascript benchmark 04:24:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.7695761296713, 3369.258763072123, 3393.0838673558155, 3394.117529442344, 3414.0, 5509.889802203954, 5558.583106267031, 5564.9721751391235, 5576.665400075998, 5585.888282234353, 5552.694601796909, 5603.131514615231, 5608.831735047945, 5616.297962754656, 5672.035753921833, 4893.119238537062, 4983.601311895049, 5136.537711605954, 5189.351331083614, 5209.765560549766, 4939.876503087434, 4954.207326827708, 4982.103221420143, 5076.898462030757, 5089.6691715038405, 5055.090083784918, 5055.9241611375855, 5110.872228194287, 5112.36095488064, 5133.768980395891, 5027.547520723152, 5050.065737838475, 5074.568661663745, 5088.84733457995, 5115.693058416507, 4928.1129396708575, 4966.379202599675, 5012.223105418666, 5039.496050394968, 5058.266551350033, 5396.83809485716, 5409.594280428983, 5426.077566813651, 5428.430014848463, 5429.809956651498, 5682.346530149044, 5886.352501224862, 5893.322267939199, 5894.292684877799, 5903.114532820068, 5880.235569375996, 5884.0585506318785, 5916.053431450947, 5929.8814023719715, 5946.821595352103, 5475.835724928259, 5477.835664930059, 5496.917546236809, 5502.119660854284, 5506.119020956668, 5954.315253745788, 5979.641221526722, 6004.939950600526, 6005.309389420186, 6051.818445446644, 5743.195952566644, 5744.195812586241, 5774.538036957033, 5784.942150578525, 5786.913196302059, 5850.297964244318, 5856.853578660568, 5856.941430585724, 5859.355470898197, 5861.824145275648, 5788.507976822018, 5833.0, 5836.649801011868, 5838.737256823453, 5881.05903055509, 5851.912221316684, 5884.529237660977, 5884.617499862496, 5888.823335299948, 5915.852103697442, 4473.575010374009, 4497.2129877271345, 4501.864944051684, 4505.211587972158, 4535.274356103007, 3944.723869329177, 3996.5603783583783, 4027.4764280643913, 4070.592940705965, 4076.5311989121037, 5603.859903502445, 5606.21512988182, 5608.635438696471, 5620.381758006616, 5623.522000629992, 5915.822525324161, 5922.1412895130825, 5923.970380148158, 5924.259467566554, 5928.881422371528, 5457.945420545744, 5600.0759874620235, 5650.26546548946, 5691.516221121251, 5695.60130790849, 4746.762661866893, 4751.883307422753, 4755.0, 4764.618830493552, 4775.6657034007985, 5941.970290148608, 5993.760249589967, 6053.576249662569, 6054.485368743618, 6064.393560643988, 5893.557983151195, 5965.821025369246, 5971.641701497924, 5974.014287642664, 5995.430434108753, 6053.606515576474, 6070.848228794315, 6096.268447786294, 6099.725512352044, 6103.938960610337, 5699.287589051369, 5794.797182098775, 5795.304563452412, 5795.623284486495, 5823.796167134299, 5885.352611212677, 5896.911546326723, 5899.321578018583, 5903.793367232126, 5926.348101708722, 5752.165935939349, 5754.251947246831, 5756.0502517084215, 5764.538836892954, 5770.961226979184, 5545.112781954868, 5728.856778580569, 5748.281464816898, 5765.855853603525, 5805.796797112081, 5581.916271255853, 5601.04782187021, 5614.7192640367, 5616.157576363578, 5697.145428185805, 5776.740046697824, 5787.160861674949, 5798.043322851851, 5799.420057994335, 5804.2744656917885, 5573.303337082864, 5728.255326807488, 5743.9138412923, 5765.250517432874, 5804.82585522435], "value": 5434.936372912333, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.4420242793626, 674.3559900295219, 678.4030053552876, 728.7194430144394, 751.0424209133357, 32430.0, 40246.0, 40660.39009414861, 40731.59268407315, 40747.38878916815, 43676.344854827206, 44188.77905610467, 44281.77859110708, 44284.0, 44424.0, 8076.71731489398, 8221.876671849897, 8798.340124490673, 8998.01021887592, 10276.126529245023, 10355.637552685657, 10500.159987201005, 10508.159347252202, 10513.0, 10514.631987880426, 10651.25441219115, 10733.83899241512, 10738.08726258265, 10740.355578665267, 10741.194410419212, 8281.875771863397, 10707.625233116842, 11014.724631884186, 11020.834687479693, 11026.173037022256, 10427.582896684124, 10522.105621022223, 10548.472576371227, 10549.578016879392, 10554.788904221949, 39584.0, 40129.0, 40327.193456131004, 40430.0, 40458.595414046074, 3949.6050394960275, 3962.623550762673, 4011.919761604781, 4367.847125350598, 4374.0, 34693.0, 35216.471752923724, 35303.0, 35432.82283588591, 35603.0, 4447.488538818045, 4454.22051141049, 4507.256302710049, 4525.683202175849, 4566.634669226454, 317578.0, 318838.0, 319063.0, 320467.0, 320754.0, 39444.60555394467, 66354.0, 66798.0, 66880.66559667171, 66887.0, 37669.81165094157, 37943.4308485373, 37949.620503794606, 37973.05067373338, 37979.0, 15952.601184970237, 17013.404530841362, 17238.569035773955, 17247.396341128002, 17287.481375558753, 14304.28478576067, 14588.270586470633, 14590.416383344547, 14593.562193134223, 14597.270136493133, 9280.489573073546, 9325.114114159143, 9349.532523373804, 9392.90607093934, 9393.060693930689, 3495.493153492729, 3602.837872295753, 3622.2936527377437, 3623.148560088377, 3643.4716966040305, 1168.4917061078459, 1211.6243964371074, 1215.7568486302775, 1241.9875801242054, 1253.8996880249558, 33387.49918751221, 33740.49389259163, 33797.49303760446, 34220.82889585536, 34890.30219395598, 1211.6001719432743, 1240.7270400511873, 1245.2092920995053, 1265.379963817741, 1379.6206043338161, 17964.261973032782, 18048.36830710945, 18128.9843442373, 18429.81570184308, 18434.539136521693, 450633.0, 459057.0, 459807.0, 460556.0, 461245.0, 63395.0, 64542.35457645457, 64857.67571162114, 64895.0, 64925.35074649193, 1356.9525066622818, 1498.887583431247, 1519.901206421579, 1521.9162946038296, 1630.7390817469147, 30040.058699876492, 33461.330773384885, 33650.0, 34286.48570271398, 34559.65440345564, 51092.0, 51137.0, 51601.7419912913, 51668.22497662613, 51717.48282517127, 287578.0, 288545.0, 288650.0, 289146.0, 289170.0, 28143.326383993488, 31270.374592507567, 31860.0, 31883.36233275275, 31903.0, 44351.55648443474, 45305.54694453145, 45451.77274113608, 46375.072498550515, 46555.0, 40042.79978600088, 41305.58694413138, 41863.50919264637, 42849.571504284555, 42993.0, 40875.26700114181, 41654.0, 42086.0, 42482.36276455794, 42806.57193428151, 43778.78110609554, 43946.560534395525, 46441.30338044865, 47046.0, 47279.0, 32995.83502082474, 34715.30569388548, 35164.64835351614, 35200.647993519735, 35665.64334356623, 27193.86403068051, 27254.318642034108, 27267.954903381928, 27314.317142071606, 27700.307492312855], "value": 19804.18905363225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.1593580966448, 424.31896805626985, 429.50177793759224, 433.63574597338237, 442.3939203291491, 17416.738748918775, 18557.907210463945, 19264.422067337968, 19270.51823704408, 19282.32511862085, 18544.907275463636, 18837.52906177346, 21212.787872121273, 22047.0, 22049.11803527861, 6414.0, 6466.773662921799, 6735.461163106939, 6740.730370785162, 6745.932540674579, 6582.670866456682, 6622.701978410959, 6666.966665166668, 6670.399664030237, 6681.699323530453, 6708.0, 6982.720691172347, 6987.790366289019, 6990.0, 7000.299970002984, 6884.690188941485, 6914.723411063552, 7177.533460325062, 7177.7487787927175, 7183.928160718378, 6840.897386539206, 6869.931300686979, 6991.19601245853, 6995.510314278003, 7021.964890175567, 25689.100881469247, 25742.87128564364, 25903.611445828326, 26053.0, 26089.0, 2710.9593356099676, 2901.390707951333, 2934.5744866994164, 2936.735693787548, 3246.594175728034, 15795.526134215992, 16127.838721612869, 16430.917845410815, 16719.91640041792, 17216.56958576033, 2240.260713964388, 2240.764719704424, 2272.6477396003647, 2289.5649826532904, 2324.070371851256, 91538.54230728804, 92075.0, 92484.53757731168, 95278.0, 95833.52083239608, 17399.65200695979, 18522.166502507418, 18549.0, 18787.248510059446, 19017.809821901603, 33799.98600042002, 33891.83054084763, 33986.0, 34497.827510862284, 34563.82718086393, 10811.297265677706, 10889.237753357347, 11004.119670426348, 11041.061509771598, 11205.103591712643, 9241.676541321021, 9297.814043719087, 9344.15902568772, 9369.48467834262, 9495.192908602847, 9100.635974561075, 9434.34898892691, 9478.478683672327, 9585.281103917234, 9661.855072173923, 3619.692326152254, 3636.3272794533095, 3638.472421498868, 3772.3775577029483, 3821.980890095532, 1039.2465462539599, 1112.7211224141558, 1151.781161579314, 1158.5655379232787, 1187.9109066819851, 17625.47123586269, 18747.531311717044, 18840.717389239173, 19499.61000780005, 19628.509287267934, 1121.9102471802237, 1122.644140733947, 1124.2692250037378, 1143.5425829668034, 1191.1602320364295, 10876.673699789018, 11306.162716334567, 11502.194846360675, 11865.0, 11978.58074967372, 564907.0, 567130.0, 573933.0, 579732.0, 583780.0, 95354.52322738481, 98483.50758246164, 98831.0, 99493.50253248688, 99875.50062249787, 1103.2663278919429, 1124.083871644607, 1161.3844662329147, 1165.7843298989715, 1168.59099315239, 17838.643227135643, 17984.19071141828, 18109.728354074963, 18253.817461825744, 18544.350947716764, 37352.43971340486, 39480.80259598684, 39969.60030399775, 40745.64449485153, 41461.37807932823, 58846.4115358858, 59472.0, 59487.0, 59507.70246148742, 59576.0, 8626.137386261324, 8727.825443490967, 8956.462612243286, 9084.227840633355, 9206.17144457002, 12908.612741617766, 13644.044916855724, 13692.52076177329, 13745.518906838213, 13919.373628186959, 12015.339156346485, 12103.818442723543, 12172.939135304267, 12233.69415764613, 12310.81533777012, 11559.479823407799, 11604.361760103275, 11736.823947640964, 11776.352300623548, 11928.0, 12425.875741242833, 12574.49702011946, 12599.559015434783, 12607.873921261036, 12616.87383126157, 8631.093735157718, 8944.195022448012, 9046.366754327133, 9048.833475016405, 9179.495127768037, 8993.415427997159, 11107.44462776874, 11415.25800822977, 11839.171258011856, 12147.574834880737], "value": 10937.587640123622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.39671338038, 1553.0836806284294, 1569.8901076924612, 1787.8301561351668, 1889.0271510172263, 7813.6483858226375, 7961.442699011071, 8003.6398362073705, 8005.359571234288, 8016.318612917895, 7620.542767433958, 7731.574763388011, 7758.456908016441, 7762.068551773781, 7773.766786996385, 2074.346580827042, 2118.0892216346965, 2118.523332250239, 2361.8464799788003, 2395.7724016218517, 2346.2374728213313, 2402.2793162051403, 2402.8197885158684, 2407.7712617301418, 2408.2534414331612, 2284.2804516577307, 2310.4570425949973, 2325.790678838904, 2328.1734984080663, 2371.9644205336936, 2063.793620637939, 2112.0812446585783, 2310.0528783198893, 2340.3330050935488, 2344.835861489688, 2059.8661087029295, 2296.70142881426, 2328.836981411302, 2345.601247787863, 2347.1784875293683, 7865.68537258509, 7899.842003159962, 7906.130325664172, 7919.089304729972, 7924.207579242087, 4991.425986011583, 5079.79680812767, 5103.4896510349035, 5114.514121158484, 5119.513646203604, 3294.2093897464674, 3349.480830471281, 3371.3257348530146, 3513.2622149348667, 3556.3065202285566, 1236.1655882279426, 1247.382545639905, 1259.703969567151, 1268.1883594499527, 1268.8540817805979, 11373.203875728703, 11377.2035957483, 11432.085433165326, 11432.599859004895, 11433.085353171726, 4498.6626003049905, 4572.977135114304, 4633.976830115827, 4639.675222734376, 4651.069806030527, 9693.273004524688, 9695.418274903528, 9705.9029409705, 9712.028797120372, 9743.464109473905, 5263.736813159403, 5267.1309233976735, 5274.973625131926, 5275.947240527622, 5278.340207474066, 4185.162967406531, 4645.3496510487885, 4747.881302967385, 4823.27650852375, 4827.782749776268, 3864.9227015460096, 3910.1202229498135, 3937.114149316381, 3963.7027222958395, 4003.339448990942, 1312.4487715159655, 1316.230005446805, 1320.9273489958146, 1327.5287273018132, 1347.353270430199, 966.6809952715587, 1033.1166852341291, 1041.9479026048666, 1048.2976405808126, 1092.229977865603, 5881.882362352729, 5950.434708702666, 5959.0, 6077.726502307407, 6079.148919151322, 484.6268373352499, 497.19950879084644, 508.105733908324, 510.6961357991989, 515.8555604430766, 4096.5903409658795, 4123.97938010308, 4135.627793498599, 4193.706440549132, 4201.264778663722, 9980.151687106532, 10281.0, 10415.218858585637, 10431.791364172826, 10453.477326133814, 10144.188464922789, 10278.074973252295, 10292.536835842406, 10298.536565854554, 10305.587776489007, 7458.552486850806, 7940.841183176304, 8069.959650201711, 8108.2297181767635, 8130.796730081795, 5777.104548794943, 5838.357780644211, 5852.970735146297, 5911.261092363455, 6021.759129634941, 8855.468671879707, 8907.10928907104, 8963.282937364866, 9027.052159523419, 9171.908280917105, 9133.40632858862, 9321.207697345802, 9339.673111441067, 9397.765055873659, 9397.906020939703, 6349.682515874096, 6375.681215939092, 6819.829504262235, 7033.648317584202, 7116.644167791694, 7166.820829479305, 7838.137804841577, 7845.725399610987, 7869.213078692314, 7872.488288261245, 6787.185537735306, 7145.9285407147345, 7148.571085734872, 7276.381507571916, 7337.119545654556, 7132.643367831484, 7139.2503787101605, 7180.281971802778, 7241.45689073311, 7250.057492525938, 6511.674416279262, 6573.685262947525, 6590.736370545316, 6624.536282460182, 6624.867502650017, 5158.690478571298, 5211.9478805211465, 5237.3453318335205, 5287.312649355559, 5290.28581141541, 5091.414487334004, 5212.9739351304515, 5228.1112210923475, 5262.184361423985, 5294.761735721979], "value": 4428.43944858232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5614294417866, 356.6326683515979, 360.5799243880879, 363.0252771309037, 368.27449923650414, 6315.431611154995, 6324.715387807542, 6333.366663333664, 6335.904961425582, 6363.618182909028, 5995.490383317423, 6116.847078823032, 6230.065490176465, 6310.24277086749, 6339.175907132067, 4825.855224343275, 4828.203346447832, 4832.951670483285, 4847.2002119650215, 4849.102915960559, 4874.8537543873745, 4889.119958407486, 4892.5596696297325, 4894.461609222983, 4905.411350637928, 4624.537546245382, 4712.787924543387, 4797.184478638623, 4856.0, 4856.3201151838775, 4821.397325334333, 4825.348577941968, 4839.637027222955, 4861.052094841507, 4862.6596138270515, 4259.978700106511, 4266.338717498793, 4278.721883077621, 4278.914421711548, 4291.763952982585, 6084.60450070744, 6086.117512960596, 6090.634561926298, 6092.147099406086, 6096.177016102858, 5647.209390685307, 5653.9151912721345, 5658.801941932013, 5659.60382773206, 5667.773289068432, 6390.456811171056, 6637.369449902251, 6645.867082658368, 6673.432758215509, 6676.86646267072, 4579.267317229227, 4590.127875703605, 4604.102200070987, 4606.424196975378, 4617.561331673485, 6915.861682766367, 6983.266756990493, 6992.755253566101, 6994.825129371807, 6995.195552511475, 4689.695169813951, 4694.131585656664, 4703.247480403119, 4706.1764191267075, 4712.175369310357, 4756.357891684647, 4757.215059515211, 4769.2369220925175, 4771.06964141989, 4773.66584339093, 5312.521873031368, 5471.85091130867, 5533.806316778893, 5542.140968149944, 5545.9722701387045, 6689.464842812563, 6712.194536655535, 6729.966350168218, 6737.056812046318, 6760.121184246115, 1573.229117732326, 1635.9856888729064, 1636.1492024147376, 1637.0341498515934, 1639.7868277123898, 1070.1492313610697, 1089.7493576477295, 1100.4827730966433, 1106.3251416635846, 1107.6732363952653, 6369.840753981095, 6454.515911306671, 6458.12815269942, 6464.385883341075, 6468.029795530708, 6777.830554236183, 6780.084688567079, 6797.0823938767635, 6809.148856392951, 6813.2846051163915, 6456.967715161394, 6463.547551671432, 6464.705029714478, 6470.12653291809, 6470.22357317125, 3659.9268014640093, 3696.4270538066644, 3699.9630003699617, 3700.20445604191, 3702.4631428442726, 6982.162140543167, 7085.716571337191, 7127.572345659173, 7133.82165445868, 7161.641917904084, 6918.169819621678, 6944.409725173316, 6960.408365289007, 6970.163580370388, 6971.407430368374, 7121.074260346226, 7123.465740069412, 7135.5361901476235, 7143.107111611049, 7143.82140446493, 6826.726930922708, 6837.145356830396, 6842.521023528305, 6844.623545705034, 6844.828879278058, 6586.0, 6744.0, 6759.594424334556, 6764.898526522008, 6765.966170169315, 7072.434205263669, 7094.503384763017, 7107.502474826712, 7121.465890058163, 7128.501004929813, 4719.834805781781, 4723.574878260973, 4725.983913458623, 4727.2436410174205, 4730.858074257778, 6803.897941530782, 6810.523263371715, 6812.8978065328065, 6813.216480104653, 6829.760958366433, 6493.772717954849, 6609.768658096944, 6689.297623749436, 6816.965915170393, 6829.351211634887, 6714.7314107437105, 6753.0, 6766.1204043476, 6767.255601883888, 6770.729170833111, 6604.306547812603, 6615.305392933673, 6619.27188009309, 6621.966890165519, 6634.237062737847, 6620.3710647488415, 6788.76239331621, 6812.931870681428, 6827.385535301847, 6835.316468353125, 6604.933950660432, 6635.734570617121, 6636.634985075867, 6639.966800165968, 6646.2356828965285], "value": 5033.638693186116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.894309268249, 842.974710758677, 852.6163226548053, 954.4368822394786, 954.9236061115112, 15170.772438413418, 15359.616009599766, 15403.537893863202, 15414.15222162782, 15420.383184672628, 14193.21937293451, 14208.431662733477, 14220.502282420117, 14228.644283892907, 14267.71464570708, 751.0424209133344, 889.9199072083511, 901.9143181397757, 903.7559858838142, 905.642271302835, 892.5849479991803, 899.0784445942928, 899.4603238057146, 900.5497251374313, 903.5437104262338, 948.0519480519481, 949.1694767078806, 951.7287573041684, 952.1383148250844, 958.8993155718654, 784.2980532423478, 931.4085555672129, 948.6015873333216, 951.0109486134412, 951.3720944176845, 695.9025736396909, 699.1470406104544, 700.4991431126718, 701.0255744515129, 701.2286484866656, 15084.924575377163, 15099.39602415913, 15134.091954482656, 15148.31832567526, 15186.316615752317, 15090.849091509053, 15508.224588770629, 15565.533034008999, 15566.221688915623, 15705.97911135784, 11999.340036298001, 12002.159848810586, 12230.633081007583, 12255.080868934776, 12470.75058498825, 3987.1228329767405, 3999.580044095357, 4018.1160144768105, 4055.8580449684414, 4131.669466442678, 56033.71983140099, 58689.0, 58768.41231587672, 59169.7041514794, 59181.40818591802, 11436.656900293005, 11620.6513804586, 11703.23928944616, 11950.880491194977, 11996.520139194334, 19805.306814261432, 20475.07862146207, 20488.38534843957, 20504.179832806818, 20516.28193013267, 8733.08302628215, 8740.694075707319, 8925.553722313858, 9106.592606627568, 9444.763880903032, 5018.071656743514, 5052.292679024939, 5153.793848246103, 5193.0, 5262.815801446931, 3615.6926661233565, 3666.2484190740834, 3668.79821609814, 3669.6330366963625, 3675.246574452231, 579.5305802300151, 673.7473447457204, 699.3670727991176, 712.056525104239, 714.2536049827942, 779.945403821727, 817.4604760857806, 824.4640983360863, 824.6536454689045, 828.3207769628847, 9508.381955172892, 9818.504333004754, 9864.161546268504, 9906.900930990741, 9960.651377201762, 687.9896801547981, 785.7407055671615, 794.8450052239758, 806.9878951815728, 810.8499927513429, 4522.796474158671, 4681.531846815359, 4731.597814185764, 4889.877753056131, 4985.725785081783, 61047.38952610417, 62263.06605400923, 62600.68699656564, 65856.0, 66448.33551664422, 50986.49013509892, 51685.22472162921, 51774.22338664923, 52949.47050529523, 53027.469725303024, 47480.525194748305, 47752.522474775506, 47845.28232076522, 48141.5185848144, 48644.513554863996, 9681.806363872542, 9730.270229732656, 9747.853782193131, 9763.316567840184, 9843.852342215016, 37738.245235095696, 38352.42471362876, 38841.805790970866, 39242.41136382899, 39411.0, 45997.310040350094, 46034.079318414115, 49601.75199123981, 50592.0, 51452.22821657753, 12617.306048167438, 12619.873801262238, 12674.0, 12820.166689165175, 12864.22814631125, 14430.350634221275, 14574.489892853699, 14685.33915973805, 14843.777343340074, 15549.0, 13759.449622015007, 14018.0, 14323.283835807959, 14418.783718244444, 14907.776383354476, 13058.869411305765, 13108.344582771015, 13202.273874936971, 13365.131266467648, 13577.728445431234, 13121.0, 13144.868551314747, 13300.201987880759, 14331.785023224451, 14370.3533341002, 10386.792264154523, 10437.843432348369, 10635.94682026585, 10720.571177152826, 10775.541749650612, 11361.261518001304, 11441.427928603704, 11740.236884602473, 11749.412529373669, 11883.227590206609], "value": 7237.149143549931, "unit": "score"}], "name": "dromaeo_css", "value": 7581.746471557767, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 111.0, 112.0, 113.0, 107.0, 111.0, 111.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 162.0, 188.0, 128.0, 152.0, 151.0, 126.0, 186.0, 128.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 158.0, 157.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 169.0, 77.0, 76.0, 76.0, 79.0, 171.0, 74.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 149.0, 93.0, 93.0, 93.0, 143.0, 92.0, 93.0, 150.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 118.0, 116.0, 117.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, 145.0, 144.0, 145.0, 155.0, 144.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 74.0, 55.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 66.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 71.0, 74.0, 72.0, 75.0, 73.0, 81.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 119.0, 112.0, 121.0, 114.0, 113.0, 111.0, 128.0, 130.0], "value": 119.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 156.0, 160.0, 159.0, 161.0, 155.0, 162.0, 154.0, 156.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 69.0, 65.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1513.9, "alertThreshold": 2.0}]} 04:24:32 INFO - Return code: 0 04:24:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:24:32 ERROR - # TBPL SUCCESS # 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - Running post-run listener: _resource_record_post_run 04:24:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 315392; Write bytes: 250822656; Read time: 364; Write time: 264424 04:24:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 5214208; Read time: 12; Write time: 244 04:24:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 311296; Write bytes: 245608448; Read time: 352; Write time: 264180 04:24:34 INFO - Running post-run listener: _upload_blobber_files 04:24:34 INFO - Blob upload gear active. 04:24:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:24:34 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:24:34 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:24:34 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:24:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:24:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:24:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:24:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:35 INFO - (blobuploader) - INFO - Done attempting. 04:24:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:24:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:24:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:36 INFO - (blobuploader) - INFO - Done attempting. 04:24:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:36 INFO - Return code: 0 04:24:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:24:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90f018c65885e9606b580bd5d07d0c6b5b621308bb5c61d080024272e0d1b826f6782c8664c0699a1ca3d4bdd8b8bce3dbb401e1093b73ea6a2ea13f130f94fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc9f7cfbb85c70fe1704d232a26952daf71c1fa79af2efa2736fd7e776b9ee6a444fb46a9314b0189b0dc7fc6e454662177d304959210d8e56c1e91fa825aa31"} 04:24:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:24:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:24:36 INFO - Contents: 04:24:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90f018c65885e9606b580bd5d07d0c6b5b621308bb5c61d080024272e0d1b826f6782c8664c0699a1ca3d4bdd8b8bce3dbb401e1093b73ea6a2ea13f130f94fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc9f7cfbb85c70fe1704d232a26952daf71c1fa79af2efa2736fd7e776b9ee6a444fb46a9314b0189b0dc7fc6e454662177d304959210d8e56c1e91fa825aa31"} 04:24:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:36 INFO - Copying logs to upload dir... 04:24:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:24:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.149198 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-11 04:24:35.997118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:36.002267) ========= 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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 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/90f018c65885e9606b580bd5d07d0c6b5b621308bb5c61d080024272e0d1b826f6782c8664c0699a1ca3d4bdd8b8bce3dbb401e1093b73ea6a2ea13f130f94fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc9f7cfbb85c70fe1704d232a26952daf71c1fa79af2efa2736fd7e776b9ee6a444fb46a9314b0189b0dc7fc6e454662177d304959210d8e56c1e91fa825aa31"} 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.011065 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/90f018c65885e9606b580bd5d07d0c6b5b621308bb5c61d080024272e0d1b826f6782c8664c0699a1ca3d4bdd8b8bce3dbb401e1093b73ea6a2ea13f130f94fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc9f7cfbb85c70fe1704d232a26952daf71c1fa79af2efa2736fd7e776b9ee6a444fb46a9314b0189b0dc7fc6e454662177d304959210d8e56c1e91fa825aa31"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:36.026588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:36.026931) ========= 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=1861a34ebfea852630dec091000001fa-1462964611.480260-616509049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:36.079468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:24:36.080250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:24:36.080583) ========= ========= Total master_lag: 0.13 =========