builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1463913152.96 results: success (0) buildid: 20160522004024 builduid: 63cd0a1e6ce04fec96e7f8af48c79ac1 revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:32.961263) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:32.961735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:32.962062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:33.007946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:33.008258) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-22 03:32:33-- 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% 46.9M=0s 2016-05-22 03:32:33 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186941 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:33.225285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:33.225633) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089861 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:33.338248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-22 03:32:33.338654) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 110e5a10dce56ed02e43c58c179e6ac101df216d --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 110e5a10dce56ed02e43c58c179e6ac101df216d --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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-22 03:32:33,591 truncating revision to first 12 chars 2016-05-22 03:32:33,591 Setting DEBUG logging. 2016-05-22 03:32:33,591 attempt 1/10 2016-05-22 03:32:33,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/110e5a10dce5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-22 03:32:34,585 unpacking tar archive at: mozilla-aurora-110e5a10dce5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.252070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-22 03:32:34.604785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:34.605116) ========= script_repo_revision: 110e5a10dce56ed02e43c58c179e6ac101df216d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:34.605586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:34.605913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 03:32:34.615354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-22 03:32:34.615694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:35 INFO - MultiFileLogger online at 20160522 03:32:35 in /builds/slave/test 03:32:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:35 INFO - {'append_to_log': False, 03:32:35 INFO - 'base_work_dir': '/builds/slave/test', 03:32:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:35 INFO - 'branch': 'Mozilla-Aurora', 03:32:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:35 INFO - 'config_files': ('talos/linux_config.py',), 03:32:35 INFO - 'default_actions': ('clobber', 03:32:35 INFO - 'read-buildbot-config', 03:32:35 INFO - 'download-and-extract', 03:32:35 INFO - 'populate-webroot', 03:32:35 INFO - 'create-virtualenv', 03:32:35 INFO - 'install', 03:32:35 INFO - 'run-tests'), 03:32:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:35 INFO - 'download_minidump_stackwalk': True, 03:32:35 INFO - 'download_symbols': 'ondemand', 03:32:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:35 INFO - 'installer_path': 'installer.exe', 03:32:35 INFO - 'log_level': 'info', 03:32:35 INFO - 'log_name': 'talos', 03:32:35 INFO - 'log_to_console': True, 03:32:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:35 INFO - 'opt_config_files': (), 03:32:35 INFO - 'pip_index': False, 03:32:35 INFO - 'sps_profile': False, 03:32:35 INFO - 'sps_profile_interval': 0, 03:32:35 INFO - 'suite': 'dromaeojs-e10s', 03:32:35 INFO - 'system_bits': '32', 03:32:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:35 INFO - 'title': 'talos-linux64-ix-039', 03:32:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:35 INFO - 'use_talos_json': True, 03:32:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:35 INFO - 'work_dir': 'build'} 03:32:35 INFO - ##### 03:32:35 INFO - ##### Running clobber step. 03:32:35 INFO - ##### 03:32:35 INFO - Running pre-action listener: _resource_record_pre_action 03:32:35 INFO - Running main action method: clobber 03:32:35 INFO - rmtree: /builds/slave/test/build 03:32:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - ##### 03:32:39 INFO - ##### Running read-buildbot-config step. 03:32:39 INFO - ##### 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: read_buildbot_config 03:32:39 INFO - Using buildbot properties: 03:32:39 INFO - { 03:32:39 INFO - "project": "", 03:32:39 INFO - "product": "firefox", 03:32:39 INFO - "script_repo_revision": "production", 03:32:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:39 INFO - "repository": "", 03:32:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:39 INFO - "buildid": "20160522004024", 03:32:39 INFO - "stage_platform": "linux64-pgo", 03:32:39 INFO - "basedir": "/builds/slave/test", 03:32:39 INFO - "nightly_build": "True", 03:32:39 INFO - "buildnumber": 325, 03:32:39 INFO - "slavename": "talos-linux64-ix-039", 03:32:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:32:39 INFO - "platform": "ubuntu64_hw", 03:32:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:39 INFO - "branch": "mozilla-aurora", 03:32:39 INFO - "repo_path": "releases/mozilla-aurora", 03:32:39 INFO - "revision": "110e5a10dce56ed02e43c58c179e6ac101df216d", 03:32:39 INFO - "pgo_build": "True", 03:32:39 INFO - "builduid": "63cd0a1e6ce04fec96e7f8af48c79ac1", 03:32:39 INFO - "slavebuilddir": "test" 03:32:39 INFO - } 03:32:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:32:39 INFO - Running post-action listener: _resource_record_post_action 03:32:39 INFO - ##### 03:32:39 INFO - ##### Running download-and-extract step. 03:32:39 INFO - ##### 03:32:39 INFO - Running pre-action listener: _resource_record_pre_action 03:32:39 INFO - Running main action method: download_and_extract 03:32:39 INFO - mkdir: /builds/slave/test/build/tests 03:32:39 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')]} 03:32:39 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:41 INFO - Downloaded 1361 bytes. 03:32:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:41 INFO - Using the following test package requirements: 03:32:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'jsshell-linux-x86_64.zip'], 03:32:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:41 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')]} 03:32:41 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:45 INFO - Downloaded 23813806 bytes. 03:32:45 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'] 03:32:45 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 03:32:46 INFO - Return code: 0 03:32:46 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 03:32:46 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')]} 03:32:46 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:48 INFO - Downloaded 23813806 bytes. 03:32:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:50 INFO - Return code: 0 03:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:50 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:54 INFO - Downloaded 10840145 bytes. 03:32:54 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'] 03:32:54 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 03:32:54 INFO - Return code: 0 03:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:54 INFO - https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/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 03:32:56 INFO - Downloaded 62733868 bytes. 03:32:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:56 INFO - mkdir: /builds/slave/test/properties 03:32:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:56 INFO - Contents: 03:32:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:57 INFO - Running post-action listener: _resource_record_post_action 03:32:57 INFO - Running post-action listener: set_extra_try_arguments 03:32:57 INFO - ##### 03:32:57 INFO - ##### Running populate-webroot step. 03:32:57 INFO - ##### 03:32:57 INFO - Running pre-action listener: _resource_record_pre_action 03:32:57 INFO - Running main action method: populate_webroot 03:32:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:57 INFO - '--tppagecycles', 03:32:57 INFO - '7'], 03:32:57 INFO - 'tests': ['tsvgm']}}, 03:32:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['damp', 'tps']}, 03:32:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['damp', 'tps']}, 03:32:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['dromaeo_dom']}, 03:32:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tsvgx', 03:32:57 INFO - 'tsvgr_opacity', 03:32:57 INFO - 'tart', 03:32:57 INFO - 'tscrollx', 03:32:57 INFO - 'cart']}, 03:32:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:57 INFO - 'tsvgr_opacity', 03:32:57 INFO - 'tart', 03:32:57 INFO - 'tscrollx', 03:32:57 INFO - 'cart']}, 03:32:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tp5o']}, 03:32:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['tp5o']}, 03:32:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s', 03:32:57 INFO - '--xperf_path', 03:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:57 INFO - 'tests': ['tp5n']}, 03:32:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--xperf_path', 03:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:57 INFO - 'tests': ['tp5n']}}, 03:32:57 INFO - 'talos.zip': {'path': '', 03:32:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:57 INFO - Running post-action listener: _resource_record_post_action 03:32:57 INFO - ##### 03:32:57 INFO - ##### Running create-virtualenv step. 03:32:57 INFO - ##### 03:32:57 INFO - Running pre-action listener: _resource_record_pre_action 03:32:57 INFO - Running main action method: create_virtualenv 03:32:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:57 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 03:32:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:57 INFO - Using real prefix '/usr' 03:32:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:00 INFO - Installing pip.................done. 03:33:00 INFO - Return code: 0 03:33:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:00 INFO - Using env: {'DISPLAY': ':0', 03:33:00 INFO - 'HOME': '/home/cltbld', 03:33:00 INFO - 'LANG': 'en_US.UTF-8', 03:33:00 INFO - 'LANGUAGE': 'en_US:en', 03:33:00 INFO - 'LOGNAME': 'cltbld', 03:33:00 INFO - 'MAIL': '/var/mail/cltbld', 03:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:00 INFO - 'MOZ_NO_REMOTE': '1', 03:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:00 INFO - 'NO_EM_RESTART': '1', 03:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:00 INFO - 'PWD': '/builds/slave/test', 03:33:00 INFO - 'SHELL': '/bin/bash', 03:33:00 INFO - 'SHLVL': '1', 03:33:00 INFO - 'TERM': 'linux', 03:33:00 INFO - 'TMOUT': '86400', 03:33:00 INFO - 'USER': 'cltbld', 03:33:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:00 INFO - '_': '/tools/buildbot/bin/python'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 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 03:33:00 INFO - Cleaning up... 03:33:00 INFO - Return code: 0 03:33:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:33:00 INFO - Using env: {'DISPLAY': ':0', 03:33:00 INFO - 'HOME': '/home/cltbld', 03:33:00 INFO - 'LANG': 'en_US.UTF-8', 03:33:00 INFO - 'LANGUAGE': 'en_US:en', 03:33:00 INFO - 'LOGNAME': 'cltbld', 03:33:00 INFO - 'MAIL': '/var/mail/cltbld', 03:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:00 INFO - 'MOZ_NO_REMOTE': '1', 03:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:00 INFO - 'NO_EM_RESTART': '1', 03:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:00 INFO - 'PWD': '/builds/slave/test', 03:33:00 INFO - 'SHELL': '/bin/bash', 03:33:00 INFO - 'SHLVL': '1', 03:33:00 INFO - 'TERM': 'linux', 03:33:00 INFO - 'TMOUT': '86400', 03:33:00 INFO - 'USER': 'cltbld', 03:33:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:00 INFO - '_': '/tools/buildbot/bin/python'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 INFO - Downloading/unpacking psutil>=0.7.1 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:02 INFO - Installing collected packages: psutil 03:33:02 INFO - Running setup.py install for psutil 03:33:02 INFO - building 'psutil._psutil_linux' extension 03:33:02 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 03:33:03 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 03:33:03 INFO - building 'psutil._psutil_posix' extension 03:33:03 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 03:33:04 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 03:33:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:04 INFO - Successfully installed psutil 03:33:04 INFO - Cleaning up... 03:33:04 INFO - Return code: 0 03:33:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:33:04 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')]} 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 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')]} 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:04 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 03:33:04 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 03:33:04 INFO - Using env: {'DISPLAY': ':0', 03:33:04 INFO - 'HOME': '/home/cltbld', 03:33:04 INFO - 'LANG': 'en_US.UTF-8', 03:33:04 INFO - 'LANGUAGE': 'en_US:en', 03:33:04 INFO - 'LOGNAME': 'cltbld', 03:33:04 INFO - 'MAIL': '/var/mail/cltbld', 03:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:04 INFO - 'MOZ_NO_REMOTE': '1', 03:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:04 INFO - 'NO_EM_RESTART': '1', 03:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:04 INFO - 'PWD': '/builds/slave/test', 03:33:04 INFO - 'SHELL': '/bin/bash', 03:33:04 INFO - 'SHLVL': '1', 03:33:04 INFO - 'TERM': 'linux', 03:33:04 INFO - 'TMOUT': '86400', 03:33:04 INFO - 'USER': 'cltbld', 03:33:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:04 INFO - '_': '/tools/buildbot/bin/python'} 03:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:33:06 INFO - Installing collected packages: mozsystemmonitor 03:33:06 INFO - Running setup.py install for mozsystemmonitor 03:33:06 INFO - Successfully installed mozsystemmonitor 03:33:06 INFO - Cleaning up... 03:33:06 INFO - Return code: 0 03:33:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:06 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:06 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 03:33:06 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 03:33:06 INFO - Using env: {'DISPLAY': ':0', 03:33:06 INFO - 'HOME': '/home/cltbld', 03:33:06 INFO - 'LANG': 'en_US.UTF-8', 03:33:06 INFO - 'LANGUAGE': 'en_US:en', 03:33:06 INFO - 'LOGNAME': 'cltbld', 03:33:06 INFO - 'MAIL': '/var/mail/cltbld', 03:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:06 INFO - 'MOZ_NO_REMOTE': '1', 03:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:06 INFO - 'NO_EM_RESTART': '1', 03:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:06 INFO - 'PWD': '/builds/slave/test', 03:33:06 INFO - 'SHELL': '/bin/bash', 03:33:06 INFO - 'SHLVL': '1', 03:33:06 INFO - 'TERM': 'linux', 03:33:06 INFO - 'TMOUT': '86400', 03:33:06 INFO - 'USER': 'cltbld', 03:33:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:06 INFO - '_': '/tools/buildbot/bin/python'} 03:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:06 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 03:33:06 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 03:33:06 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 03:33:06 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 03:33:06 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 03:33:06 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 03:33:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:08 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 03:33:08 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 03:33:08 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 03:33:08 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 03:33:08 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 03:33:08 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 03:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:09 INFO - Downloading docopt-0.6.1.tar.gz 03:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:09 INFO - Running setup.py install for blobuploader 03:33:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:09 INFO - Running setup.py install for requests 03:33:09 INFO - Running setup.py install for docopt 03:33:09 INFO - Successfully installed blobuploader requests docopt 03:33:09 INFO - Cleaning up... 03:33:09 INFO - Return code: 0 03:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:09 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:09 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 03:33:09 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 03:33:09 INFO - Using env: {'DISPLAY': ':0', 03:33:09 INFO - 'HOME': '/home/cltbld', 03:33:09 INFO - 'LANG': 'en_US.UTF-8', 03:33:09 INFO - 'LANGUAGE': 'en_US:en', 03:33:09 INFO - 'LOGNAME': 'cltbld', 03:33:09 INFO - 'MAIL': '/var/mail/cltbld', 03:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:09 INFO - 'MOZ_NO_REMOTE': '1', 03:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:09 INFO - 'NO_EM_RESTART': '1', 03:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:09 INFO - 'PWD': '/builds/slave/test', 03:33:09 INFO - 'SHELL': '/bin/bash', 03:33:09 INFO - 'SHLVL': '1', 03:33:09 INFO - 'TERM': 'linux', 03:33:09 INFO - 'TMOUT': '86400', 03:33:09 INFO - 'USER': 'cltbld', 03:33:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:09 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:10 INFO - Running setup.py (path:/tmp/pip-i5sZA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:10 INFO - Running setup.py (path:/tmp/pip-GHwO_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:10 INFO - Running setup.py (path:/tmp/pip-dc0Egb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:10 INFO - Running setup.py (path:/tmp/pip-maOSDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:10 INFO - Running setup.py (path:/tmp/pip-822q5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:10 INFO - Running setup.py (path:/tmp/pip-4hJJOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:10 INFO - Running setup.py (path:/tmp/pip-n5ZAlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:10 INFO - Running setup.py (path:/tmp/pip-K5DDj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:10 INFO - Running setup.py (path:/tmp/pip-ofvJBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:10 INFO - Running setup.py (path:/tmp/pip-5Jb6iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:10 INFO - Running setup.py (path:/tmp/pip-difE91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:10 INFO - Running setup.py (path:/tmp/pip-JDV5IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:11 INFO - Running setup.py (path:/tmp/pip-G0E1qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:11 INFO - Running setup.py (path:/tmp/pip-zMTLCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:11 INFO - Running setup.py (path:/tmp/pip-wmQj25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:11 INFO - Running setup.py (path:/tmp/pip-wqFYIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:11 INFO - Running setup.py (path:/tmp/pip-BKV4WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:11 INFO - Running setup.py install for manifestparser 03:33:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozcrash 03:33:11 INFO - Running setup.py install for mozdebug 03:33:11 INFO - Running setup.py install for mozdevice 03:33:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozfile 03:33:11 INFO - Running setup.py install for mozhttpd 03:33:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozinfo 03:33:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for mozInstall 03:33:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for mozleak 03:33:12 INFO - Running setup.py install for mozlog 03:33:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for moznetwork 03:33:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for mozprocess 03:33:12 INFO - Running setup.py install for mozprofile 03:33:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for mozrunner 03:33:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:12 INFO - Running setup.py install for mozscreenshot 03:33:12 INFO - Running setup.py install for moztest 03:33:13 INFO - Running setup.py install for mozversion 03:33:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:13 INFO - Cleaning up... 03:33:13 INFO - Return code: 0 03:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:13 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:13 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 03:33:13 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 03:33:13 INFO - Using env: {'DISPLAY': ':0', 03:33:13 INFO - 'HOME': '/home/cltbld', 03:33:13 INFO - 'LANG': 'en_US.UTF-8', 03:33:13 INFO - 'LANGUAGE': 'en_US:en', 03:33:13 INFO - 'LOGNAME': 'cltbld', 03:33:13 INFO - 'MAIL': '/var/mail/cltbld', 03:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:13 INFO - 'MOZ_NO_REMOTE': '1', 03:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:13 INFO - 'NO_EM_RESTART': '1', 03:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:13 INFO - 'PWD': '/builds/slave/test', 03:33:13 INFO - 'SHELL': '/bin/bash', 03:33:13 INFO - 'SHLVL': '1', 03:33:13 INFO - 'TERM': 'linux', 03:33:13 INFO - 'TMOUT': '86400', 03:33:13 INFO - 'USER': 'cltbld', 03:33:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:13 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:13 INFO - Running setup.py (path:/tmp/pip-Et6Vhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:13 INFO - Running setup.py (path:/tmp/pip-vVhMCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:13 INFO - Running setup.py (path:/tmp/pip-Dpd7Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:13 INFO - Running setup.py (path:/tmp/pip-GShrpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:13 INFO - Running setup.py (path:/tmp/pip-NDUTt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:13 INFO - Running setup.py (path:/tmp/pip-XIu0Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:13 INFO - Running setup.py (path:/tmp/pip-UG2aGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:13 INFO - Running setup.py (path:/tmp/pip-VLWaWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:13 INFO - Running setup.py (path:/tmp/pip-sRIaw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:14 INFO - Running setup.py (path:/tmp/pip-hjB4kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:14 INFO - Running setup.py (path:/tmp/pip-QUEUWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:14 INFO - Running setup.py (path:/tmp/pip-F5qaSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:14 INFO - Running setup.py (path:/tmp/pip-AGu54h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:14 INFO - Running setup.py (path:/tmp/pip-xaoAhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:14 INFO - Running setup.py (path:/tmp/pip-uKdCVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:14 INFO - Running setup.py (path:/tmp/pip-M5Lb17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:14 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)) 03:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:14 INFO - Running setup.py (path:/tmp/pip-pPGaXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:14 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)) 03:33:14 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)) 03:33:14 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)) 03:33:14 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)) 03:33:14 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)) 03:33:14 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)) 03:33:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:16 INFO - Downloading blessings-1.6.tar.gz 03:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:16 INFO - Installing collected packages: blessings 03:33:16 INFO - Running setup.py install for blessings 03:33:16 INFO - Successfully installed blessings 03:33:16 INFO - Cleaning up... 03:33:16 INFO - Return code: 0 03:33:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:16 INFO - Reading from file tmpfile_stdout 03:33:16 INFO - Current package versions: 03:33:16 INFO - argparse == 1.2.1 03:33:16 INFO - blessings == 1.6 03:33:16 INFO - blobuploader == 1.2.4 03:33:16 INFO - docopt == 0.6.1 03:33:16 INFO - manifestparser == 1.1 03:33:16 INFO - mozInstall == 1.12 03:33:16 INFO - mozcrash == 0.17 03:33:16 INFO - mozdebug == 0.1 03:33:16 INFO - mozdevice == 0.48 03:33:16 INFO - mozfile == 1.2 03:33:16 INFO - mozhttpd == 0.7 03:33:16 INFO - mozinfo == 0.9 03:33:16 INFO - mozleak == 0.1 03:33:16 INFO - mozlog == 3.1 03:33:16 INFO - moznetwork == 0.27 03:33:16 INFO - mozprocess == 0.22 03:33:16 INFO - mozprofile == 0.28 03:33:16 INFO - mozrunner == 6.11 03:33:16 INFO - mozscreenshot == 0.1 03:33:16 INFO - mozsystemmonitor == 0.0 03:33:16 INFO - moztest == 0.7 03:33:16 INFO - mozversion == 1.4 03:33:16 INFO - psutil == 3.1.1 03:33:16 INFO - requests == 1.2.3 03:33:16 INFO - wsgiref == 0.1.2 03:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:16 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:16 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 03:33:16 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 03:33:16 INFO - Using env: {'DISPLAY': ':0', 03:33:16 INFO - 'HOME': '/home/cltbld', 03:33:16 INFO - 'LANG': 'en_US.UTF-8', 03:33:16 INFO - 'LANGUAGE': 'en_US:en', 03:33:16 INFO - 'LOGNAME': 'cltbld', 03:33:16 INFO - 'MAIL': '/var/mail/cltbld', 03:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:16 INFO - 'MOZ_NO_REMOTE': '1', 03:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:16 INFO - 'NO_EM_RESTART': '1', 03:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:16 INFO - 'PWD': '/builds/slave/test', 03:33:16 INFO - 'SHELL': '/bin/bash', 03:33:16 INFO - 'SHLVL': '1', 03:33:16 INFO - 'TERM': 'linux', 03:33:16 INFO - 'TMOUT': '86400', 03:33:16 INFO - 'USER': 'cltbld', 03:33:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:16 INFO - '_': '/tools/buildbot/bin/python'} 03:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 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)) 03:33:17 INFO - Cleaning up... 03:33:17 INFO - Return code: 0 03:33:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:17 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')]} 03:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:17 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')]} 03:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:17 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:17 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 03:33:17 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 03:33:17 INFO - Using env: {'DISPLAY': ':0', 03:33:17 INFO - 'HOME': '/home/cltbld', 03:33:17 INFO - 'LANG': 'en_US.UTF-8', 03:33:17 INFO - 'LANGUAGE': 'en_US:en', 03:33:17 INFO - 'LOGNAME': 'cltbld', 03:33:17 INFO - 'MAIL': '/var/mail/cltbld', 03:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:17 INFO - 'MOZ_NO_REMOTE': '1', 03:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:17 INFO - 'NO_EM_RESTART': '1', 03:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:17 INFO - 'PWD': '/builds/slave/test', 03:33:17 INFO - 'SHELL': '/bin/bash', 03:33:17 INFO - 'SHLVL': '1', 03:33:17 INFO - 'TERM': 'linux', 03:33:17 INFO - 'TMOUT': '86400', 03:33:17 INFO - 'USER': 'cltbld', 03:33:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:17 INFO - '_': '/tools/buildbot/bin/python'} 03:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:17 INFO - Downloading/unpacking jsonschema 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:19 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:19 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:19 INFO - warning: no files found matching '*.txt' 03:33:19 INFO - no previously-included directories found matching 'build' 03:33:19 INFO - no previously-included directories found matching 'dist' 03:33:19 INFO - no previously-included directories found matching '.git*' 03:33:19 INFO - Installing collected packages: jsonschema, functools32 03:33:19 INFO - Running setup.py install for functools32 03:33:19 INFO - warning: no files found matching '*.txt' 03:33:19 INFO - no previously-included directories found matching 'build' 03:33:19 INFO - no previously-included directories found matching 'dist' 03:33:19 INFO - no previously-included directories found matching '.git*' 03:33:19 INFO - Successfully installed jsonschema functools32 03:33:19 INFO - Cleaning up... 03:33:19 INFO - Return code: 0 03:33:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:19 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 0x7f0e01bddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', '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 03:33:19 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 03:33:19 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 03:33:19 INFO - Using env: {'DISPLAY': ':0', 03:33:19 INFO - 'HOME': '/home/cltbld', 03:33:19 INFO - 'LANG': 'en_US.UTF-8', 03:33:19 INFO - 'LANGUAGE': 'en_US:en', 03:33:19 INFO - 'LOGNAME': 'cltbld', 03:33:19 INFO - 'MAIL': '/var/mail/cltbld', 03:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:19 INFO - 'MOZ_NO_REMOTE': '1', 03:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:19 INFO - 'NO_EM_RESTART': '1', 03:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:19 INFO - 'PWD': '/builds/slave/test', 03:33:19 INFO - 'SHELL': '/bin/bash', 03:33:19 INFO - 'SHLVL': '1', 03:33:19 INFO - 'TERM': 'linux', 03:33:19 INFO - 'TMOUT': '86400', 03:33:19 INFO - 'USER': 'cltbld', 03:33:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:19 INFO - '_': '/tools/buildbot/bin/python'} 03:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:19 INFO - Downloading/unpacking flake8 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 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 03:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:22 INFO - no previously-included directories found matching 'docs/_build' 03:33:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:22 INFO - Running setup.py install for pep8 03:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:22 INFO - no previously-included directories found matching 'docs/_build' 03:33:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:22 INFO - Cleaning up... 03:33:22 INFO - Return code: 0 03:33:22 INFO - Running post-action listener: _resource_record_post_action 03:33:22 INFO - Running post-action listener: _start_resource_monitoring 03:33:22 INFO - Starting resource monitoring. 03:33:22 INFO - ##### 03:33:22 INFO - ##### Running install step. 03:33:22 INFO - ##### 03:33:22 INFO - Running pre-action listener: _resource_record_pre_action 03:33:22 INFO - Running main action method: install 03:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:23 INFO - Reading from file tmpfile_stdout 03:33:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:23 INFO - Reading from file tmpfile_stdout 03:33:23 INFO - Output received: 03:33:23 INFO - Usage: mozinstall [options] installer 03:33:23 INFO - Options: 03:33:23 INFO - -h, --help show this help message and exit 03:33:23 INFO - -d DEST, --destination=DEST 03:33:23 INFO - Directory to install application into. [default: 03:33:23 INFO - "/builds/slave/test"] 03:33:23 INFO - --app=APP Application being installed. [default: firefox] 03:33:23 INFO - mkdir: /builds/slave/test/build/application 03:33:23 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'] 03:33:23 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 03:33:38 INFO - Reading from file tmpfile_stdout 03:33:38 INFO - Output received: 03:33:38 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:38 INFO - Running post-action listener: _resource_record_post_action 03:33:38 INFO - ##### 03:33:38 INFO - ##### Running run-tests step. 03:33:38 INFO - ##### 03:33:38 INFO - Running pre-action listener: _resource_record_pre_action 03:33:38 INFO - Running main action method: run_tests 03:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:38 INFO - Python 2.7.3 03:33:38 INFO - Return code: 0 03:33:38 INFO - grabbing minidump binary from tooltool 03:33: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')]} 03:33:38 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 0x1167640>, '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 0x1168540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11689d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:38 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 03:33:38 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 03:33:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:38 INFO - Return code: 0 03:33:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:39 INFO - Return code: 0 03:33:39 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:33:39 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:33:39 INFO - Using env: {'DISPLAY': ':0', 03:33:39 INFO - 'HOME': '/home/cltbld', 03:33:39 INFO - 'LANG': 'en_US.UTF-8', 03:33:39 INFO - 'LANGUAGE': 'en_US:en', 03:33:39 INFO - 'LOGNAME': 'cltbld', 03:33:39 INFO - 'MAIL': '/var/mail/cltbld', 03:33:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:39 INFO - 'MOZ_NO_REMOTE': '1', 03:33:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:39 INFO - 'NO_EM_RESTART': '1', 03:33:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:39 INFO - 'PWD': '/builds/slave/test', 03:33:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:39 INFO - 'SHELL': '/bin/bash', 03:33:39 INFO - 'SHLVL': '1', 03:33:39 INFO - 'TERM': 'linux', 03:33:39 INFO - 'TMOUT': '86400', 03:33:39 INFO - 'USER': 'cltbld', 03:33:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685', 03:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:39 INFO - '_': '/tools/buildbot/bin/python'} 03:33:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:33:40 INFO - mozversion application_buildid: 20160522004024 03:33:40 INFO - mozversion application_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 03:33:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:40 INFO - mozversion application_name: Firefox 03:33:40 INFO - mozversion application_remotingname: firefox-dev 03:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:40 INFO - mozversion application_vendor: Mozilla 03:33:40 INFO - mozversion application_version: 48.0a2 03:33:40 INFO - mozversion platform_buildid: 20160522004024 03:33:40 INFO - mozversion platform_changeset: 110e5a10dce56ed02e43c58c179e6ac101df216d 03:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:40 INFO - mozversion platform_version: 48.0a2 03:33:40 INFO - using testdate: 1463913220 03:33:40 INFO - actual date: 1463913220 03:33:40 INFO - starting webserver on 'localhost:54967' 03:33:40 INFO - SUITE-START | Running 2 tests 03:33:40 INFO - TEST-START | dromaeo_css 03:33:40 INFO - operating with platform_type : linux_ 03:33:40 INFO - Initialising browser for dromaeo_css test... 03:33:40 INFO - TEST-INFO | started process 3341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3yy1Xj/profile http://localhost:54967/getInfo.html) 03:33:46 INFO - PROCESS | 3341 | 03:33:46 INFO - PROCESS | 3341 | (process:3423): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:33:47 INFO - PROCESS | 3341 | __metrics Screen width/height:1600/1200 03:33:47 INFO - PROCESS | 3341 | colorDepth:24 03:33:47 INFO - PROCESS | 3341 | Browser inner width/height: 1024/697 03:33:47 INFO - PROCESS | 3341 | __metrics 03:33:48 ERROR - PROCESS | 3341 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:33:49 INFO - TEST-INFO | 3341: exit 0 03:33:49 INFO - Browser initialized. 03:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:49 INFO - TEST-INFO | started process 3474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3yy1Xj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:51 INFO - PROCESS | 3474 | 03:33:51 INFO - PROCESS | 3474 | (process:3545): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:34:01 INFO - PROCESS | 3474 | RSS: Main: 151998464 03:34:01 INFO - PROCESS | 3474 | 03:34:51 INFO - PROCESS | 3474 | 1463913291062 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] 03:36:58 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54967/tests/dromaeo/cssquery-ext.html) 03:36:59 INFO - PROCESS | 3474 | RSS: Main: 156119040 03:36:59 INFO - PROCESS | 3474 | 03:40:01 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-ext.html (next: http://localhost:54967/tests/dromaeo/cssquery-jquery.html) 03:40:01 INFO - PROCESS | 3474 | RSS: Main: 153808896 03:40:01 INFO - PROCESS | 3474 | 03:43:03 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54967/tests/dromaeo/cssquery-mootools.html) 03:43:03 INFO - PROCESS | 3474 | RSS: Main: 152834048 03:43:03 INFO - PROCESS | 3474 | 03:46:05 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54967/tests/dromaeo/cssquery-prototype.html) 03:46:06 INFO - PROCESS | 3474 | RSS: Main: 152846336 03:46:06 INFO - PROCESS | 3474 | 03:49:08 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54967/tests/dromaeo/cssquery-yui.html) 03:49:09 INFO - PROCESS | 3474 | RSS: Main: 154505216 03:49:09 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | Cycle 1(1): loaded http://localhost:54967/tests/dromaeo/cssquery-yui.html (next: http://localhost:54967/tests/dromaeo/cssquery-dojo.html) 03:52:11 INFO - PROCESS | 3474 | RSS: Main: 156016640 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | __start_tp_report 03:52:11 INFO - PROCESS | 3474 | _x_x_mozilla_page_load 03:52:11 INFO - PROCESS | 3474 | _x_x_mozilla_page_load_details 03:52:11 INFO - PROCESS | 3474 | |i|pagename|runs| 03:52:11 INFO - PROCESS | 3474 | |0;dojo.html;3253.7722359434847;3274.7216486598636;3288.9506657400143;3300.438925382685;3327.0850516108067;5515.117581187011;5527.032769265377;5558.138488534273;5563.833085007451;5566.944330556693;5517.36550296716;5543.251661025771;5550.111982082867;5564.944350556493;5585.944140558593;5003.09944210043;5054.469280725526;5108.948910510884;5153.922691159635;5204.375474943012;4943.8516844494725;4994.625403094764;5038.244263360507;5150.253213284091;5223.138182199932;5007.349044624194;5010.72441015744;5030.496950304959;5045.697258164503;5089.872753181182;5073.898522029557;5079.66982146163;5091.465396133427;5094.184930411154;5098;4856.757162141878;4913.091078150554;4970.055689418999;4973.154563724175;4984.37695288089;5288;5376.623636345457;5385.057614917374;5387.272718183073;5388.838334849961;5825.533957283407;5843.941560584382;5845.06478963368;5856.385079566669;5858.3848695886745;5784.623999440023;5871.412858714137;5879.382664820175;5880.353161152269;5927.73325200367;5454.8909021819345;5473.67157970519;5482.259894914176;5490.231367608538;5516.172574113875;5807.912881306699;5921.28944526651;5968.9701551492835;5973.074173503114;5981.102834574848;5707.942920570824;5734.627249228787;5751.9424805751405;5754.367019627837;5789.855253618609;5837.591368604242;5838.824835254949;5844.561657875676;5851.151583020438;5852.853678658068;5692.8861422771315;5759.395263497272;5808.796692115756;5814.447627475383;5893.233879595711;5767.653940763567;5806.564507661942;5807;5810.854728631818;5811;4442.955570444319;4452.821887124479;4455.977720111378;4459.175052615276;4478.596926276651;3913.9608603914166;3944.9408258876138;3957.149212919236;3973.7019723520275;3979.4908519452406;5484.643498172606;5568.49883510486;5587.273654424899;5594.524465420403;5640.85897852557;5750.137479378043;5812.0119579671555;5823.854403639943;5836.941630583725;5845.210896528999;5448.945510544923;5500.724963751796;5611.074172761449;5639.210510528529;5640.464155905182;4970.279309500174;4992.425871024879;5087.516685914832;5090.083784918676;5117.053345131163;6044.607100538451;6046.879062418727;6078.726457309432;6094.695265236721;6095.116208149793;5629.690367029689;5838.678872662044;5868.794592189253;5883.14694369314;5891.734871930774;6007.30915944672;6056.878862422815;6119.350229749377;6121.4490695837585;6133.172021777182;5715.114157305624;5735.71321433935;5739.9139012915675;5741.856453588526;5753.884922301447;5729.598928074995;5822.039363504974;5836.678982655994;5857.26784151981;5866.442687944638;5747.655140691572;5759.568032397503;5762.135679648086;5777.50891174238;5806.854828629318;5682.176084467646;5688.914666280092;5716.371199168171;5739.253896993364;5742.712864356849;5476.753546090516;5596.188552659923;5607.663540187602;5650.491455769001;5687.033204355187;5738.340090889435;5774.076147816497;5775.104858746901;5784.652920824764;5803.767849285981;5617.073182924772;5659.434056594472;5675.0636145035605;5675.233843431249;5679.6876171810945 03:52:11 INFO - PROCESS | 3474 | |1;ext.html;645.1097485470051;669.9062131301619;678.5623272988922;680.0343512212656;735.716749051615;37694.62305376949;38274.04314892122;38357.61642383575;38390.61609383905;38543;42277.7886110569;42859.57140428595;42990.35514467285;43060;43139.78430107845;8713.302935765123;8818.338624603148;8874.511901845395;8890.244329231991;8896.555172241395;8814.603342849556;8942.597583108776;8946.194842464178;8947.150020748051;8966.372353935227;9181.173694367506;9259.768505787342;9264.258859291274;9278.814423711521;9296.070392960717;9160.587773550173;9203.907960920438;9213.723588292361;9223.262139028862;9225.308101892351;8980.640774369018;9153.313501487415;9156.725298241063;9171.312151588658;9171.44971301724;43102.78448607768;43845;43920.78039609813;44026.55973440289;44205.336919946225;3785.886423407302;3869.4776205212215;4004.3993400989793;4106.301928672133;4600.35595016698;33159.502607460905;33303.83348083244;33386.33227335464;33397.499037514455;34778.826105869564;4476.731396116244;4480.439945006874;4481.462224533045;4509.751963641998;4560.156371071363;309289;310741;310930;311960;312621;55585.72207139019;55609;55799.16301255485;55867.720661397245;55936.999999999185;68012;68049.65975170191;68263.31736682668;68334.65832670804;68902.65548672224;16584;16718.080505572067;16737.497875063767;16743.16284185786;16838.073905935293;14137.08108972934;14138.43446262138;14166.433342666383;14197.929010355088;14225.928870355581;20139.19443222284;20164.39506814798;20215.696764548542;20324.288649897477;21148.47128821792;7655.617219139132;7788.299053085137;7999.120096789348;8000.279974802295;8051.51690898548;1063.5745701719375;1187.340357598972;1189.7025743564109;1230.6123571075082;1263.1031967303134;33120;33202;33298.01047745558;33508.49737253894;33947.490787638206;1214.319980810731;1214.611324376191;1316.0787448785698;1347.0907137682025;1352.384664977433;17060.82939170617;17161.31354745796;17294.221760020577;17441.912790435967;17468.388606398716;465410;478443;607812;933661;950444;61793.69103154456;62732.37267627357;62871.05693414602;63047.36952630415;63255.68372158202;1433.806436131109;1526.542037388779;1540.6687562173963;1543.413502868925;1558.844115588432;32385.190370240933;32550.674493254763;33053.834730826195;33214.335713286084;33809.49285760765;52396;53253.73373133109;53284;53389;53490;456743;458894;459078;460055;460638;29932.551011734406;30378.39243215079;30525.23686907845;30550.541741873447;30762.692373075985;48390.27414588854;48787;48931.75534122306;49222;49248.50751492583;41272.79363603163;41405.171896562504;41532.1693566133;42940.785296074566;42986.35520467133;39809;40611.593884061964;40962.38556421596;41121.38317925174;41310.38034429426;42391.57608424;42752.78623606862;43005.78497107494;44513.55486445094;45732.31401528913;32227.838860805547;34283.828580856934;34702;36157.81921090378;36435.63564364429;28447.146585602466;28692.856535717186;28753;29103.272418189714;29311.413771724874 03:52:11 INFO - PROCESS | 3474 | |2;jquery.html;411.7961609003544;419.15958503201085;426.17109721591515;426.7716771527233;438.76087532294895;14669.706605867876;18576.16407261673;19259.325923592678;19317;19332.613347733037;16029.278682459288;16253.431129910456;16281.592960176002;16791.916040419812;19035.524111897208;5696.544276457894;5901.232839730829;5914.497267732248;5917.319508256541;5925.644461332312;5655.349634792011;5906.793262235823;5924.407559244062;5952.55355848311;5990.071538911476;5849.795257166;5873.412658734135;5908.32054313753;5919.082542205965;5942.851428714273;5438.8912221755545;5671.149327600851;5681.147827825818;5693.971530142364;5703.17303990921;5352.384475785296;5547.389787123413;5549.944500555023;5600.1599760035915;5615.578831587606;13172.802407963889;13280.601581952556;13354.532591359255;17102.914485427493;21785.455363615878;2391.175044609607;2393.8324317297797;2521.5461216980934;2705.837649741022;2964.902985895211;9534.904650953471;9701.6604418845;9743.512824358753;10213.2850700451;10239.436830974293;1981.2471260920902;2023.3323003408839;2046.467918341227;2065.493953981284;2118.936431907045;72347.27652723459;80438.19561804365;80954;81173.59413202896;82151.589242054;11195.664130076111;11476.368799716096;11495.3677547734;11642.476088576035;11761.353125578175;16442.588935276715;16540;16546.751798722787;16551.420700275434;16580.917095414687;8729.607167677343;8749.387542872066;8765.07966663504;8820.294376449869;8942.687005954891;8555.401121921406;8835;8852.38033337673;8886.51124188163;8957.731268061969;4626.86119416418;4748.453927798348;4859.805607775649;4952.925706114411;5017.724025178651;1958.8628795984143;2119.6184686756533;2127.1597718901257;2166.1985065525855;2182.454386403399;1022.7392015036119;1044.556063672936;1112.360392774158;1113.1540029577418;1118.6308518188978;18617.348392806456;19025.238990440226;19261.807381926003;19526;19910.303139390053;1046.5499835070993;1086.3264775838873;1104.8784633690289;1111.8832522585012;1139.743557699511;10786.892131078746;11074.723131921604;11144.33134011962;11229.27009744364;11231.382273974847;523142;529541;536503;536780;537406;91259;91469;92700.53649731708;94202;94297.0835541245;1095.4194277033184;1096.8848270931596;1151.83874257604;1161.35544772652;1182.6688527212393;17137.571560711083;17480.12599370001;17602.207900644247;17648.205830737905;17987;39034.2193156141;39094.609053909095;39629.603703963745;39683.2063358737;41224.175516490104;58275;58281.70859145677;58578.70710646419;58773.706131469065;58965.410345895994;8573.528455934984;8637.481751094954;8696.478211307342;8809.251213646912;8861.113888611088;12322.445489952794;12966.22202667843;13100.541481048118;13244.404001820134;13519.459221631418;11495.8275625864;11731.47208375608;11970.22193557416;12266.75466490683;12307.56923507673;6124.724387402489;8608.62262038071;11448.198626096426;12243.387830608612;12323.198992065487;12151.149419540547;12352.62942111738;12474.126811123135;12548.874511254771;12763.106582539132;8639.784005399915;8683.739487815375;8721.302295816193;8781.51701656415;8789.780255493664;11744.119191060534;12330.63008109758;12438.937805310916;12483.251004939733;12544.121911466109 03:52:11 INFO - PROCESS | 3474 | |3;mootools.html;1561.1491737003334;1561.9375224991002;1780.4895097911947;1859.5351162209456;1898.591802762406;7377.88933166003;7988.400869934763;8065.2741253287195;8241.093479717227;8258.42191046627;8402.957985210065;8442.409031367806;8491.745247642566;8520.275776558985;8545.102764209762;2257.1084421653477;2281.133169395627;2282.052948026567;2283.8058765004994;2286.451251699597;2248.347979086063;2265.444965983328;2268.9319320420414;2283.212291759349;2291.2667946257206;2249.8200143988524;2272;2283.4291427143216;2294.7475777664527;2296.8047715944167;2259.344790010895;2293.6330187170056;2297.9540409191804;2299.379167624749;2303.896324665394;2100.705901173837;2132.3176583493287;2134.9146034158616;2136.9893150534303;2138.4012476506605;8557.358198135102;8573.785655358604;8575.056743758181;8638.697645582375;8669.739907802776;5245;5342.572594192494;5357.946420535784;5370.650907691027;5379.542738867201;3346.5649465569563;3435.9656403435897;3547.4146765783617;3569.5894972078286;3592.4252119660728;1117.3854380090918;1128.136975213962;1166.632510759108;1186.2052424875353;1193.3675152169365;12102;12186.81719774213;12200;12207.572734954234;12220.388980550937;4493.820247190141;4553.066621342617;4588;4590.104929538775;4632.351470794091;9596.280278978966;9613.230941524662;9624.711258662112;9638.566264518113;9652.662156824477;5229.581633469314;5231.450697676765;5237.423883372826;5247.475252474722;5265.21021846726;4726.834560790356;4839.637027222972;4860.1008813369635;4866.489018653061;4877.244027175793;3843.385058390644;3898.941515877264;3951.565327813938;3963.841446342172;3972.066564357374;1180.504188240941;1186.4364426897328;1209.6492017314881;1217.9512819487122;1221.145198361133;954.2270760683869;987.2891518106951;1009.1472705563787;1015.1067060986285;1041.9166466682648;5762.538996880239;5783.16144159103;5830.038043722739;5880.500157486576;5942.227510423617;941.9670311539063;983.5033308179467;1077.385890042668;1077.8544896439037;1109.57836022311;3858.2476417098956;4068.5727998559723;4110.34234522481;4177.143685544456;4204.558521355275;9829.361091529028;9927.453990030474;10175.745606359753;10225.846612300822;10560.313579617301;10702.090322322534;10826.40454774995;10861.239713220157;10931.398773067558;10951.123910087334;8234.835303293901;8241.752747417468;8396.664133434595;8444.535550544657;8513.787155321166;5504.6421982571;5539.8892022160135;5625.437456254342;5697.6296540724725;5716.056850619601;9632.325737198329;9672.70981870545;9756.365836220622;9762.219022478326;9835.262355323237;9369.25045996305;9557.665481708107;9959.103680668775;10026.94986525092;10036.297459177787;6626.171728533934;6808.489363297872;6977.1278590176225;7187.928120718935;7303.817404564716;7831.530108193527;7831.647575859214;7833.1775163607;7854.253845884632;7930.801729956566;6787.321267873371;7066.964665176847;7165.964170179116;7198;7229.891551626624;7006.2643422439905;7018.473614478832;7060.611666358194;7125;7150.392216661642;6794.966025169842;6838.14523184602;6887.139107611549;6892.241853396022;6904.4131248844415;5127.256547800623;5137.17805151174;5143.408508021475;5144.614153938394;5178.792848286026;4926.433460152129;4972.428170760409;4976.129177394014;4981.327520784647;4991.5008499151245 03:52:11 INFO - PROCESS | 3474 | |4;prototype.html;345.5732170769101;346.4664416798131;350.56179775280896;355.9448285515743;357.5530586766542;6683.966580167104;6692;6752.054712340277;6765.627890466022;6791.456683465317;6584.802455926318;6604.2074951005825;6634.104395906551;6638.73445062197;6657.866842663144;4821.397325334333;4999;5001.099802035632;5007;5015.3730783652045;4925.802967881298;4930.161872481687;4930.852074437755;4931.2603109533675;4948.554630083292;4852.781624826891;4860.368152140217;4914.311996320518;4933.7286449245275;4936.851894443173;4937.580305673986;4940.629452791037;4947.950520494803;4954.554090131869;4956.231784073474;4278.935815962763;4283.978580107079;4284.742915425085;4288.078063216392;4289.270823959903;6390.233172019387;6403.103565500834;6413.390727880844;6414.775482858125;6418.1656384669695;5653.717314134318;5698.287714035746;5765.365809760923;5767.106098554731;5784.219130417382;6971.58170509771;7024.578525288448;7028.753993610199;7046.5067445278855;7047.612381319025;4688.68716759308;4694.600958918496;4731.550502702238;4735.479097299294;4739.478657347689;7281.5631062136445;7283.053203083618;7304.780856574312;7320.084989376328;7364.079490063742;4725.834595789131;4762.3808904842845;4763.499832517605;4772.904541909143;4778.1638213312535;4697.389339385858;4836.274558816206;4847.927281090787;4856.465788763233;4884.975575122173;5690.6870122142855;5716.714164291852;5724;5724.084146536534;5731.742071606787;6946.9579563065945;6975.9302406975285;7050.541714788523;7052.118485189351;7057.082579264663;1689.3580439432938;1713.9143042847809;1714.9742753858702;1715.5625315544457;1723.9482815515555;1029.1920842138884;1057.8095942730383;1075.9031687148195;1087.4019289390803;1101.6364599682086;6815.250322464525;6856.588604683735;6859.07402500656;6860.656967151623;6870.45036397087;7279.963600181965;7328.413726901835;7329.853402932018;7339.266073392618;7351.154617219088;6731.966340168267;6848.212455567574;6855.177378714586;6860.211075726355;6965.442764578822;3983.661388781986;4005.7796821174534;4026.879193624196;4027.335489644176;4035.9394609080887;7666.080070391588;7699.653515591812;7727.111382191008;7734.4585878989055;7736.071671399468;7515.8496830063095;7534.924650753423;7540.547567145989;7563.432742544222;7595.772126836204;7410.814729631802;7689.961550192325;7690.961545192238;7703.768886933401;7710.421718371144;7307.41540676734;7322.560646361236;7364.742234021784;7373.33639972405;7374.151972523228;7197.784066477804;7230.783076507713;7238.6018768968215;7247.311505406978;7261.963690181516;7684.46208765381;7691.923080769345;7712.421568382281;7715.112762032438;7722.459427839997;4555.066211426583;4665.603423708887;4669.089527542097;4717.457492388419;4823.782929768098;7263.818404539928;7317.26827317264;7317.853642927218;7334.853302933805;7336.889946650911;7063.752768653072;7109.289071093056;7144.892826607709;7146.678399471933;7147.606881621561;7037.366637002694;7040.471964602573;7067.222605513287;7077.433805295461;7083.893741593984;6808.625525595941;6934.583924964519;6969.2682268361095;6978.825529361604;6983.987321838204;7109.75115870942;7112.182099058675;7127.180374257026;7152.85694286101;7158.785236442915;6925.93074069273;6968.65156742171;6970.825729356604;6973.16322041338;6992.2308546058875 03:52:11 INFO - PROCESS | 3474 | |5;yui.html;795.7175202803005;864.3042350907521;918.7565295196772;939.844925587278;950.5199874063596;13657.863421365784;14306.928465357658;14309.856901430983;14317.57047288583;14401;13785.586432407019;13841.238731869744;13927.164370137798;13944.233067181302;13945.233012184326;915.8763566918481;923.2475532441073;933.8645896345059;937.9062093790601;946.0917519181594;919.8482250428672;926.5645146781002;935.4854829843558;936.0358830404695;936.9906300937006;967.569431602937;968.5544649461257;974.6978436684615;979.6522234606718;982.086659406755;957.5260246178117;962.3888830592554;968.5157421289356;968.9854652180223;971.3637567393333;714.4391652552721;714.7819914925946;715.5134508534195;717.4654882112807;720.7369310201739;15325.386984520606;15337;15444.073355598588;15456.845431545766;15470.845291547053;13725.45098196071;13927.860721392757;14233.28833558318;14264.643383915381;14447.133172009608;11687.474063667156;11737.413129343498;12218.694532636666;12263.325517096557;12398.256104633661;3947.940780888289;4006.4791577094793;4042.090529630839;4059.7361171523758;4118.135191609766;57490.13764793531;57561.13658295129;57652.42347576513;58748.706256468875;59118;11174.888251117547;11249.550017999189;11270.7182320441;11314.434278286053;11435.656930292105;20328.593428131353;20638.58722825535;20682.896585516977;20764;20843.895780521303;8608.09614990417;8778.034416214212;8815.426997245158;8934.642614295355;8976.640934362553;4908.2146856503505;4973.676711013845;4982.427020892571;5055.090083784954;5153.974230128901;3611.223586928823;3634.309481198564;3635.327464419091;3635.472856435802;3644.7448678592773;624.7313655128247;643.9581427207216;661.4897900488916;665.3845193196274;669.5547460938421;782.9530228186327;784.2471227621547;799.4923223752959;824.686619084756;834.6995081770558;9573.473458959685;9712.125908668253;9757.170640495495;9855.75360615976;9871.30900836949;630.8801327747805;745.0947099274408;745.9664315105833;753.3408267765705;756.0964647246598;4533.569310915458;4628.39830821991;4777.140114779304;4808.567228949411;4892.535209155125;61515.38484615186;63307.6834615824;67570.32429675739;67919;67980.32019679839;53228.73385633047;53340.46659533433;54072.91854162973;54297.45702543003;57597.712011439675;52136.739316303174;54406.53129579243;54479.18281225706;54496.45503544914;54820.45179548153;9642.951785241028;10011.699649010541;10057.69826905194;10094.697159085239;10100.6574156283;36893.631063690096;38152.809235953646;38625;39345;39607.40588891227;42328.365074524525;48095.5190448091;50073.499265008344;50095.74952125216;50651.746741266055;12194.878051219373;12235.265884046985;12588.181768185039;12685.112042156961;12835.871641283467;13621.114627549177;14125.152490850582;14137.787933180805;14152.292385380895;14872.925635371754;12302.75394492123;12351.313009057387;12476.937615311865;12653.240805551697;12673;11906.940465297965;12387.380630968595;12559.37203139821;12908.870911290767;13321.467141314239;12169.2698438094;13042.282674452996;13066.216027038408;13081.542146024844;13086.280254585708;10899.945500272448;10913.727156821144;11145.442727863736;11188.66434006981;11219.046381057702;11204.327740335606;11209.71975700614;11261.71845703864;11361.204715669825;11376.488058037243 03:52:11 INFO - PROCESS | 3474 | __end_tp_report 03:52:11 INFO - PROCESS | 3474 | __start_cc_report 03:52:11 INFO - PROCESS | 3474 | _x_x_mozilla_cycle_collect,336 03:52:11 INFO - PROCESS | 3474 | __end_cc_report 03:52:11 INFO - PROCESS | 3474 | __startTimestamp1463914331623__endTimestamp 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | ------- Summary: start ------- 03:52:11 INFO - PROCESS | 3474 | Number of tests: 6 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#0] dojo.html Cycles:165 Average:5448.29 Median:5675.06 stddev:596.90 (10.5%) stddev-sans-first:573.37 03:52:11 INFO - PROCESS | 3474 | Values: 3253.8 3274.7 3289.0 3300.4 3327.1 5515.1 5527.0 5558.1 5563.8 5566.9 5517.4 5543.3 5550.1 5564.9 5585.9 5003.1 5054.5 5108.9 5153.9 5204.4 4943.9 4994.6 5038.2 5150.3 5223.1 5007.3 5010.7 5030.5 5045.7 5089.9 5073.9 5079.7 5091.5 5094.2 5098.0 4856.8 4913.1 4970.1 4973.2 4984.4 5288.0 5376.6 5385.1 5387.3 5388.8 5825.5 5843.9 5845.1 5856.4 5858.4 5784.6 5871.4 5879.4 5880.4 5927.7 5454.9 5473.7 5482.3 5490.2 5516.2 5807.9 5921.3 5969.0 5973.1 5981.1 5707.9 5734.6 5751.9 5754.4 5789.9 5837.6 5838.8 5844.6 5851.2 5852.9 5692.9 5759.4 5808.8 5814.4 5893.2 5767.7 5806.6 5807.0 5810.9 5811.0 4443.0 4452.8 4456.0 4459.2 4478.6 3914.0 3944.9 3957.1 3973.7 3979.5 5484.6 5568.5 5587.3 5594.5 5640.9 5750.1 5812.0 5823.9 5836.9 5845.2 5448.9 5500.7 5611.1 5639.2 5640.5 4970.3 4992.4 5087.5 5090.1 5117.1 6044.6 6046.9 6078.7 6094.7 6095.1 5629.7 5838.7 5868.8 5883.1 5891.7 6007.3 6056.9 6119.4 6121.4 6133.2 5715.1 5735.7 5739.9 5741.9 5753.9 5729.6 5822.0 5836.7 5857.3 5866.4 5747.7 5759.6 5762.1 5777.5 5806.9 5682.2 5688.9 5716.4 5739.3 5742.7 5476.8 5596.2 5607.7 5650.5 5687.0 5738.3 5774.1 5775.1 5784.7 5803.8 5617.1 5659.4 5675.1 5675.2 5679.7 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#1] ext.html Cycles:180 Average:64633.36 Median:42900.18 stddev:140894.05 (328.4%) stddev-sans-first:141207.38 03:52:11 INFO - PROCESS | 3474 | Values: 645.1 669.9 678.6 680.0 735.7 37694.6 38274.0 38357.6 38390.6 38543.0 42277.8 42859.6 42990.4 43060.0 43139.8 8713.3 8818.3 8874.5 8890.2 8896.6 8814.6 8942.6 8946.2 8947.2 8966.4 9181.2 9259.8 9264.3 9278.8 9296.1 9160.6 9203.9 9213.7 9223.3 9225.3 8980.6 9153.3 9156.7 9171.3 9171.4 43102.8 43845.0 43920.8 44026.6 44205.3 3785.9 3869.5 4004.4 4106.3 4600.4 33159.5 33303.8 33386.3 33397.5 34778.8 4476.7 4480.4 4481.5 4509.8 4560.2 309289.0 310741.0 310930.0 311960.0 312621.0 55585.7 55609.0 55799.2 55867.7 55937.0 68012.0 68049.7 68263.3 68334.7 68902.7 16584.0 16718.1 16737.5 16743.2 16838.1 14137.1 14138.4 14166.4 14197.9 14225.9 20139.2 20164.4 20215.7 20324.3 21148.5 7655.6 7788.3 7999.1 8000.3 8051.5 1063.6 1187.3 1189.7 1230.6 1263.1 33120.0 33202.0 33298.0 33508.5 33947.5 1214.3 1214.6 1316.1 1347.1 1352.4 17060.8 17161.3 17294.2 17441.9 17468.4 465410.0 478443.0 607812.0 933661.0 950444.0 61793.7 62732.4 62871.1 63047.4 63255.7 1433.8 1526.5 1540.7 1543.4 1558.8 32385.2 32550.7 33053.8 33214.3 33809.5 52396.0 53253.7 53284.0 53389.0 53490.0 456743.0 458894.0 459078.0 460055.0 460638.0 29932.6 30378.4 30525.2 30550.5 30762.7 48390.3 48787.0 48931.8 49222.0 49248.5 41272.8 41405.2 41532.2 42940.8 42986.4 39809.0 40611.6 40962.4 41121.4 41310.4 42391.6 42752.8 43005.8 44513.6 45732.3 32227.8 34283.8 34702.0 36157.8 36435.6 28447.1 28692.9 28753.0 29103.3 29311.4 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#2] jquery.html Cycles:180 Average:29972.69 Median:2392.50 stddev:87613.51 (3662.0%) stddev-sans-first:87831.17 03:52:11 INFO - PROCESS | 3474 | Values: 411.8 419.2 426.2 426.8 438.8 14669.7 18576.2 19259.3 19317.0 19332.6 16029.3 16253.4 16281.6 16791.9 19035.5 5696.5 5901.2 5914.5 5917.3 5925.6 5655.3 5906.8 5924.4 5952.6 5990.1 5849.8 5873.4 5908.3 5919.1 5942.9 5438.9 5671.1 5681.1 5694.0 5703.2 5352.4 5547.4 5549.9 5600.2 5615.6 13172.8 13280.6 13354.5 17102.9 21785.5 2391.2 2393.8 2521.5 2705.8 2964.9 9534.9 9701.7 9743.5 10213.3 10239.4 1981.2 2023.3 2046.5 2065.5 2118.9 72347.3 80438.2 80954.0 81173.6 82151.6 11195.7 11476.4 11495.4 11642.5 11761.4 16442.6 16540.0 16546.8 16551.4 16580.9 8729.6 8749.4 8765.1 8820.3 8942.7 8555.4 8835.0 8852.4 8886.5 8957.7 4626.9 4748.5 4859.8 4952.9 5017.7 1958.9 2119.6 2127.2 2166.2 2182.5 1022.7 1044.6 1112.4 1113.2 1118.6 18617.3 19025.2 19261.8 19526.0 19910.3 1046.5 1086.3 1104.9 1111.9 1139.7 10786.9 11074.7 11144.3 11229.3 11231.4 523142.0 529541.0 536503.0 536780.0 537406.0 91259.0 91469.0 92700.5 94202.0 94297.1 1095.4 1096.9 1151.8 1161.4 1182.7 17137.6 17480.1 17602.2 17648.2 17987.0 39034.2 39094.6 39629.6 39683.2 41224.2 58275.0 58281.7 58578.7 58773.7 58965.4 8573.5 8637.5 8696.5 8809.3 8861.1 12322.4 12966.2 13100.5 13244.4 13519.5 11495.8 11731.5 11970.2 12266.8 12307.6 6124.7 8608.6 11448.2 12243.4 12323.2 12151.1 12352.6 12474.1 12548.9 12763.1 8639.8 8683.7 8721.3 8781.5 8789.8 11744.1 12330.6 12438.9 12483.3 12544.1 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#3] mootools.html Cycles:180 Average:5613.21 Median:5059.38 stddev:3129.60 (61.9%) stddev-sans-first:3123.56 03:52:11 INFO - PROCESS | 3474 | Values: 1561.1 1561.9 1780.5 1859.5 1898.6 7377.9 7988.4 8065.3 8241.1 8258.4 8403.0 8442.4 8491.7 8520.3 8545.1 2257.1 2281.1 2282.1 2283.8 2286.5 2248.3 2265.4 2268.9 2283.2 2291.3 2249.8 2272.0 2283.4 2294.7 2296.8 2259.3 2293.6 2298.0 2299.4 2303.9 2100.7 2132.3 2134.9 2137.0 2138.4 8557.4 8573.8 8575.1 8638.7 8669.7 5245.0 5342.6 5357.9 5370.7 5379.5 3346.6 3436.0 3547.4 3569.6 3592.4 1117.4 1128.1 1166.6 1186.2 1193.4 12102.0 12186.8 12200.0 12207.6 12220.4 4493.8 4553.1 4588.0 4590.1 4632.4 9596.3 9613.2 9624.7 9638.6 9652.7 5229.6 5231.5 5237.4 5247.5 5265.2 4726.8 4839.6 4860.1 4866.5 4877.2 3843.4 3898.9 3951.6 3963.8 3972.1 1180.5 1186.4 1209.6 1218.0 1221.1 954.2 987.3 1009.1 1015.1 1041.9 5762.5 5783.2 5830.0 5880.5 5942.2 942.0 983.5 1077.4 1077.9 1109.6 3858.2 4068.6 4110.3 4177.1 4204.6 9829.4 9927.5 10175.7 10225.8 10560.3 10702.1 10826.4 10861.2 10931.4 10951.1 8234.8 8241.8 8396.7 8444.5 8513.8 5504.6 5539.9 5625.4 5697.6 5716.1 9632.3 9672.7 9756.4 9762.2 9835.3 9369.3 9557.7 9959.1 10026.9 10036.3 6626.2 6808.5 6977.1 7187.9 7303.8 7831.5 7831.6 7833.2 7854.3 7930.8 6787.3 7067.0 7166.0 7198.0 7229.9 7006.3 7018.5 7060.6 7125.0 7150.4 6795.0 6838.1 6887.1 6892.2 6904.4 5127.3 5137.2 5143.4 5144.6 5178.8 4926.4 4972.4 4976.1 4981.3 4991.5 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#4] prototype.html Cycles:180 Average:5874.95 Median:6800.04 stddev:1842.44 (27.1%) stddev-sans-first:1800.26 03:52:11 INFO - PROCESS | 3474 | Values: 345.6 346.5 350.6 355.9 357.6 6684.0 6692.0 6752.1 6765.6 6791.5 6584.8 6604.2 6634.1 6638.7 6657.9 4821.4 4999.0 5001.1 5007.0 5015.4 4925.8 4930.2 4930.9 4931.3 4948.6 4852.8 4860.4 4914.3 4933.7 4936.9 4937.6 4940.6 4948.0 4954.6 4956.2 4278.9 4284.0 4284.7 4288.1 4289.3 6390.2 6403.1 6413.4 6414.8 6418.2 5653.7 5698.3 5765.4 5767.1 5784.2 6971.6 7024.6 7028.8 7046.5 7047.6 4688.7 4694.6 4731.6 4735.5 4739.5 7281.6 7283.1 7304.8 7320.1 7364.1 4725.8 4762.4 4763.5 4772.9 4778.2 4697.4 4836.3 4847.9 4856.5 4885.0 5690.7 5716.7 5724.0 5724.1 5731.7 6947.0 6975.9 7050.5 7052.1 7057.1 1689.4 1713.9 1715.0 1715.6 1723.9 1029.2 1057.8 1075.9 1087.4 1101.6 6815.3 6856.6 6859.1 6860.7 6870.5 7280.0 7328.4 7329.9 7339.3 7351.2 6732.0 6848.2 6855.2 6860.2 6965.4 3983.7 4005.8 4026.9 4027.3 4035.9 7666.1 7699.7 7727.1 7734.5 7736.1 7515.8 7534.9 7540.5 7563.4 7595.8 7410.8 7690.0 7691.0 7703.8 7710.4 7307.4 7322.6 7364.7 7373.3 7374.2 7197.8 7230.8 7238.6 7247.3 7262.0 7684.5 7691.9 7712.4 7715.1 7722.5 4555.1 4665.6 4669.1 4717.5 4823.8 7263.8 7317.3 7317.9 7334.9 7336.9 7063.8 7109.3 7144.9 7146.7 7147.6 7037.4 7040.5 7067.2 7077.4 7083.9 6808.6 6934.6 6969.3 6978.8 6984.0 7109.8 7112.2 7127.2 7152.9 7158.8 6925.9 6968.7 6970.8 6973.2 6992.2 03:52:11 INFO - PROCESS | 3474 | 03:52:11 INFO - PROCESS | 3474 | [#5] yui.html Cycles:180 Average:15592.94 Median:4580.98 stddev:18031.74 (393.6%) stddev-sans-first:18048.09 03:52:11 INFO - PROCESS | 3474 | Values: 795.7 864.3 918.8 939.8 950.5 13657.9 14306.9 14309.9 14317.6 14401.0 13785.6 13841.2 13927.2 13944.2 13945.2 915.9 923.2 933.9 937.9 946.1 919.8 926.6 935.5 936.0 937.0 967.6 968.6 974.7 979.7 982.1 957.5 962.4 968.5 969.0 971.4 714.4 714.8 715.5 717.5 720.7 15325.4 15337.0 15444.1 15456.8 15470.8 13725.5 13927.9 14233.3 14264.6 14447.1 11687.5 11737.4 12218.7 12263.3 12398.3 3947.9 4006.5 4042.1 4059.7 4118.1 57490.1 57561.1 57652.4 58748.7 59118.0 11174.9 11249.6 11270.7 11314.4 11435.7 20328.6 20638.6 20682.9 20764.0 20843.9 8608.1 8778.0 8815.4 8934.6 8976.6 4908.2 4973.7 4982.4 5055.1 5154.0 3611.2 3634.3 3635.3 3635.5 3644.7 624.7 644.0 661.5 665.4 669.6 783.0 784.2 799.5 824.7 834.7 9573.5 9712.1 9757.2 9855.8 9871.3 630.9 745.1 746.0 753.3 756.1 4533.6 4628.4 4777.1 4808.6 4892.5 61515.4 63307.7 67570.3 67919.0 67980.3 53228.7 53340.5 54072.9 54297.5 57597.7 52136.7 54406.5 54479.2 54496.5 54820.5 9643.0 10011.7 10057.7 10094.7 10100.7 36893.6 38152.8 38625.0 39345.0 39607.4 42328.4 48095.5 50073.5 50095.7 50651.7 12194.9 12235.3 12588.2 12685.1 12835.9 13621.1 14125.2 14137.8 14152.3 14872.9 12302.8 12351.3 12476.9 12653.2 12673.0 11906.9 12387.4 12559.4 12908.9 13321.5 12169.3 13042.3 13066.2 13081.5 13086.3 10899.9 10913.7 11145.4 11188.7 11219.0 11204.3 11209.7 11261.7 11361.2 11376.5 03:52:11 INFO - PROCESS | 3474 | -------- Summary: end -------- 03:52:11 INFO - PROCESS | 3474 | 03:52:12 INFO - TEST-INFO | 3474: exit 0 03:52:12 INFO - TEST-OK | dromaeo_css | took 1112273ms 03:52:12 INFO - TEST-START | kraken 03:52:12 INFO - operating with platform_type : linux_ 03:52:12 INFO - Initialising browser for kraken test... 03:52:12 INFO - TEST-INFO | started process 3714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkZ706/profile http://localhost:54967/getInfo.html) 03:52:16 INFO - PROCESS | 3714 | 03:52:16 INFO - PROCESS | 3714 | (process:3793): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:17 INFO - PROCESS | 3714 | __metrics Screen width/height:1600/1200 03:52:17 INFO - PROCESS | 3714 | colorDepth:24 03:52:17 INFO - PROCESS | 3714 | Browser inner width/height: 1024/697 03:52:17 INFO - PROCESS | 3714 | __metrics 03:52:17 ERROR - PROCESS | 3714 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:52:18 INFO - TEST-INFO | 3714: exit 0 03:52:18 INFO - Browser initialized. 03:52:18 INFO - Running cycle 1/1 for kraken test... 03:52:18 INFO - TEST-INFO | started process 3844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplkZ706/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:20 INFO - PROCESS | 3844 | 03:52:20 INFO - PROCESS | 3844 | (process:3913): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:30 INFO - PROCESS | 3844 | RSS: Main: 152080384 03:52:30 INFO - PROCESS | 3844 | 03:52:33 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54967/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:33 INFO - PROCESS | 3844 | RSS: Main: 156696576 03:52:33 INFO - PROCESS | 3844 | 03:52:36 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54967/tests/kraken/driver.html?testName=audio-dft) 03:52:37 INFO - PROCESS | 3844 | RSS: Main: 157089792 03:52:37 INFO - PROCESS | 3844 | 03:52:40 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54967/tests/kraken/driver.html?testName=audio-fft) 03:52:40 INFO - PROCESS | 3844 | RSS: Main: 157261824 03:52:40 INFO - PROCESS | 3844 | 03:52:42 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54967/tests/kraken/driver.html?testName=audio-oscillator) 03:52:43 INFO - PROCESS | 3844 | RSS: Main: 157626368 03:52:43 INFO - PROCESS | 3844 | 03:52:45 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:46 INFO - PROCESS | 3844 | RSS: Main: 157339648 03:52:46 INFO - PROCESS | 3844 | 03:52:49 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54967/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:49 INFO - PROCESS | 3844 | RSS: Main: 157372416 03:52:49 INFO - PROCESS | 3844 | 03:52:53 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54967/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:53 INFO - PROCESS | 3844 | RSS: Main: 157470720 03:52:53 INFO - PROCESS | 3844 | 03:52:56 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54967/tests/kraken/driver.html?testName=json-parse-financial) 03:52:57 INFO - PROCESS | 3844 | RSS: Main: 157388800 03:52:57 INFO - PROCESS | 3844 | 03:52:58 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:59 INFO - PROCESS | 3844 | RSS: Main: 157650944 03:52:59 INFO - PROCESS | 3844 | 03:53:01 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:02 INFO - PROCESS | 3844 | RSS: Main: 157212672 03:53:02 INFO - PROCESS | 3844 | 03:53:03 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:04 INFO - PROCESS | 3844 | RSS: Main: 157790208 03:53:04 INFO - PROCESS | 3844 | 03:53:06 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:07 INFO - PROCESS | 3844 | RSS: Main: 157818880 03:53:07 INFO - PROCESS | 3844 | 03:53:10 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:10 INFO - PROCESS | 3844 | RSS: Main: 157728768 03:53:10 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | Cycle 1(1): loaded http://localhost:54967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54967/tests/kraken/driver.html?testName=ai-astar) 03:53:12 INFO - PROCESS | 3844 | RSS: Main: 159404032 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | __start_tp_report 03:53:12 INFO - PROCESS | 3844 | _x_x_mozilla_page_load 03:53:12 INFO - PROCESS | 3844 | _x_x_mozilla_page_load_details 03:53:12 INFO - PROCESS | 3844 | |i|pagename|runs| 03:53:12 INFO - PROCESS | 3844 | |0;ai-astar;111;112;104;109;112;110;102;111;110;111 03:53:12 INFO - PROCESS | 3844 | |1;audio-beat-detection;158;128;151;170;127;152;154;129;191;132 03:53:12 INFO - PROCESS | 3844 | |2;audio-dft;164;164;164;163;164;162;161;161;162;161 03:53:12 INFO - PROCESS | 3844 | |3;audio-fft;73;75;74;174;74;76;75;75;159;76 03:53:12 INFO - PROCESS | 3844 | |4;audio-oscillator;94;92;145;91;92;92;151;93;93;144 03:53:12 INFO - PROCESS | 3844 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;117;117;117 03:53:12 INFO - PROCESS | 3844 | |6;imaging-darkroom;147;147;147;147;147;149;147;147;147;146 03:53:12 INFO - PROCESS | 3844 | |7;imaging-desaturate;95;96;95;96;95;95;96;96;96;95 03:53:12 INFO - PROCESS | 3844 | |8;json-parse-financial;55;56;55;55;56;56;56;79;54;54 03:53:12 INFO - PROCESS | 3844 | |9;json-stringify-tinderbox;57;57;57;57;57;56;57;57;57;57 03:53:12 INFO - PROCESS | 3844 | |10;stanford-crypto-aes;79;72;74;73;82;74;76;74;74;73 03:53:12 INFO - PROCESS | 3844 | |11;stanford-crypto-ccm;123;116;112;116;132;117;113;115;133;129 03:53:12 INFO - PROCESS | 3844 | |12;stanford-crypto-pbkdf2;171;160;163;163;161;172;160;162;158;163 03:53:12 INFO - PROCESS | 3844 | |13;stanford-crypto-sha256-iterative;67;68;68;66;68;68;67;66;66;66 03:53:12 INFO - PROCESS | 3844 | __end_tp_report 03:53:12 INFO - PROCESS | 3844 | __start_cc_report 03:53:12 INFO - PROCESS | 3844 | _x_x_mozilla_cycle_collect,832 03:53:12 INFO - PROCESS | 3844 | __end_cc_report 03:53:12 INFO - PROCESS | 3844 | __startTimestamp1463914392761__endTimestamp 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | ------- Summary: start ------- 03:53:12 INFO - PROCESS | 3844 | Number of tests: 14 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.57 03:53:12 INFO - PROCESS | 3844 | Values: 111.0 112.0 104.0 109.0 112.0 110.0 102.0 111.0 110.0 111.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.00 stddev:20.92 (13.7%) stddev-sans-first:21.94 03:53:12 INFO - PROCESS | 3844 | Values: 158.0 128.0 151.0 170.0 127.0 152.0 154.0 129.0 191.0 132.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.50 stddev:1.35 (0.8%) stddev-sans-first:1.33 03:53:12 INFO - PROCESS | 3844 | Values: 164.0 164.0 164.0 163.0 164.0 162.0 161.0 161.0 162.0 161.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:38.86 (51.8%) stddev-sans-first:40.53 03:53:12 INFO - PROCESS | 3844 | Values: 73.0 75.0 74.0 174.0 74.0 76.0 75.0 75.0 159.0 76.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:26.27 (28.6%) stddev-sans-first:27.32 03:53:12 INFO - PROCESS | 3844 | Values: 94.0 92.0 145.0 91.0 92.0 92.0 151.0 93.0 93.0 144.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:53:12 INFO - PROCESS | 3844 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:53:12 INFO - PROCESS | 3844 | Values: 147.0 147.0 147.0 147.0 147.0 149.0 147.0 147.0 147.0 146.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:53:12 INFO - PROCESS | 3844 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:7.56 (13.5%) stddev-sans-first:7.96 03:53:12 INFO - PROCESS | 3844 | Values: 55.0 56.0 55.0 55.0 56.0 56.0 56.0 79.0 54.0 54.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 03:53:12 INFO - PROCESS | 3844 | Values: 57.0 57.0 57.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:3.11 (4.2%) stddev-sans-first:2.96 03:53:12 INFO - PROCESS | 3844 | Values: 79.0 72.0 74.0 73.0 82.0 74.0 76.0 74.0 74.0 73.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.00 stddev:8.02 (6.7%) stddev-sans-first:8.46 03:53:12 INFO - PROCESS | 3844 | Values: 123.0 116.0 112.0 116.0 132.0 117.0 113.0 115.0 133.0 129.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.00 stddev:4.62 (2.8%) stddev-sans-first:3.97 03:53:12 INFO - PROCESS | 3844 | Values: 171.0 160.0 163.0 163.0 161.0 172.0 160.0 162.0 158.0 163.0 03:53:12 INFO - PROCESS | 3844 | 03:53:12 INFO - PROCESS | 3844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:0.94 (1.4%) stddev-sans-first:1.00 03:53:12 INFO - PROCESS | 3844 | Values: 67.0 68.0 68.0 66.0 68.0 68.0 67.0 66.0 66.0 66.0 03:53:12 INFO - PROCESS | 3844 | -------- Summary: end -------- 03:53:12 INFO - PROCESS | 3844 | 03:53:13 INFO - TEST-INFO | 3844: exit 0 03:53:13 INFO - TEST-OK | kraken | took 61410ms 03:53:13 INFO - SUITE-END | took 1173s 03:53:13 INFO - Completed test suite (00:19:33) 03:53:13 INFO - javascript benchmark 03:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.7722359434847, 3274.7216486598636, 3288.9506657400143, 3300.438925382685, 3327.0850516108067, 5515.117581187011, 5527.032769265377, 5558.138488534273, 5563.833085007451, 5566.944330556693, 5517.36550296716, 5543.251661025771, 5550.111982082867, 5564.944350556493, 5585.944140558593, 5003.09944210043, 5054.469280725526, 5108.948910510884, 5153.922691159635, 5204.375474943012, 4943.8516844494725, 4994.625403094764, 5038.244263360507, 5150.253213284091, 5223.138182199932, 5007.349044624194, 5010.72441015744, 5030.496950304959, 5045.697258164503, 5089.872753181182, 5073.898522029557, 5079.66982146163, 5091.465396133427, 5094.184930411154, 5098.0, 4856.757162141878, 4913.091078150554, 4970.055689418999, 4973.154563724175, 4984.37695288089, 5288.0, 5376.623636345457, 5385.057614917374, 5387.272718183073, 5388.838334849961, 5825.533957283407, 5843.941560584382, 5845.06478963368, 5856.385079566669, 5858.3848695886745, 5784.623999440023, 5871.412858714137, 5879.382664820175, 5880.353161152269, 5927.73325200367, 5454.8909021819345, 5473.67157970519, 5482.259894914176, 5490.231367608538, 5516.172574113875, 5807.912881306699, 5921.28944526651, 5968.9701551492835, 5973.074173503114, 5981.102834574848, 5707.942920570824, 5734.627249228787, 5751.9424805751405, 5754.367019627837, 5789.855253618609, 5837.591368604242, 5838.824835254949, 5844.561657875676, 5851.151583020438, 5852.853678658068, 5692.8861422771315, 5759.395263497272, 5808.796692115756, 5814.447627475383, 5893.233879595711, 5767.653940763567, 5806.564507661942, 5807.0, 5810.854728631818, 5811.0, 4442.955570444319, 4452.821887124479, 4455.977720111378, 4459.175052615276, 4478.596926276651, 3913.9608603914166, 3944.9408258876138, 3957.149212919236, 3973.7019723520275, 3979.4908519452406, 5484.643498172606, 5568.49883510486, 5587.273654424899, 5594.524465420403, 5640.85897852557, 5750.137479378043, 5812.0119579671555, 5823.854403639943, 5836.941630583725, 5845.210896528999, 5448.945510544923, 5500.724963751796, 5611.074172761449, 5639.210510528529, 5640.464155905182, 4970.279309500174, 4992.425871024879, 5087.516685914832, 5090.083784918676, 5117.053345131163, 6044.607100538451, 6046.879062418727, 6078.726457309432, 6094.695265236721, 6095.116208149793, 5629.690367029689, 5838.678872662044, 5868.794592189253, 5883.14694369314, 5891.734871930774, 6007.30915944672, 6056.878862422815, 6119.350229749377, 6121.4490695837585, 6133.172021777182, 5715.114157305624, 5735.71321433935, 5739.9139012915675, 5741.856453588526, 5753.884922301447, 5729.598928074995, 5822.039363504974, 5836.678982655994, 5857.26784151981, 5866.442687944638, 5747.655140691572, 5759.568032397503, 5762.135679648086, 5777.50891174238, 5806.854828629318, 5682.176084467646, 5688.914666280092, 5716.371199168171, 5739.253896993364, 5742.712864356849, 5476.753546090516, 5596.188552659923, 5607.663540187602, 5650.491455769001, 5687.033204355187, 5738.340090889435, 5774.076147816497, 5775.104858746901, 5784.652920824764, 5803.767849285981, 5617.073182924772, 5659.434056594472, 5675.0636145035605, 5675.233843431249, 5679.6876171810945], "value": 5409.62536755268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.1097485470051, 669.9062131301619, 678.5623272988922, 680.0343512212656, 735.716749051615, 37694.62305376949, 38274.04314892122, 38357.61642383575, 38390.61609383905, 38543.0, 42277.7886110569, 42859.57140428595, 42990.35514467285, 43060.0, 43139.78430107845, 8713.302935765123, 8818.338624603148, 8874.511901845395, 8890.244329231991, 8896.555172241395, 8814.603342849556, 8942.597583108776, 8946.194842464178, 8947.150020748051, 8966.372353935227, 9181.173694367506, 9259.768505787342, 9264.258859291274, 9278.814423711521, 9296.070392960717, 9160.587773550173, 9203.907960920438, 9213.723588292361, 9223.262139028862, 9225.308101892351, 8980.640774369018, 9153.313501487415, 9156.725298241063, 9171.312151588658, 9171.44971301724, 43102.78448607768, 43845.0, 43920.78039609813, 44026.55973440289, 44205.336919946225, 3785.886423407302, 3869.4776205212215, 4004.3993400989793, 4106.301928672133, 4600.35595016698, 33159.502607460905, 33303.83348083244, 33386.33227335464, 33397.499037514455, 34778.826105869564, 4476.731396116244, 4480.439945006874, 4481.462224533045, 4509.751963641998, 4560.156371071363, 309289.0, 310741.0, 310930.0, 311960.0, 312621.0, 55585.72207139019, 55609.0, 55799.16301255485, 55867.720661397245, 55936.999999999185, 68012.0, 68049.65975170191, 68263.31736682668, 68334.65832670804, 68902.65548672224, 16584.0, 16718.080505572067, 16737.497875063767, 16743.16284185786, 16838.073905935293, 14137.08108972934, 14138.43446262138, 14166.433342666383, 14197.929010355088, 14225.928870355581, 20139.19443222284, 20164.39506814798, 20215.696764548542, 20324.288649897477, 21148.47128821792, 7655.617219139132, 7788.299053085137, 7999.120096789348, 8000.279974802295, 8051.51690898548, 1063.5745701719375, 1187.340357598972, 1189.7025743564109, 1230.6123571075082, 1263.1031967303134, 33120.0, 33202.0, 33298.01047745558, 33508.49737253894, 33947.490787638206, 1214.319980810731, 1214.611324376191, 1316.0787448785698, 1347.0907137682025, 1352.384664977433, 17060.82939170617, 17161.31354745796, 17294.221760020577, 17441.912790435967, 17468.388606398716, 465410.0, 478443.0, 607812.0, 933661.0, 950444.0, 61793.69103154456, 62732.37267627357, 62871.05693414602, 63047.36952630415, 63255.68372158202, 1433.806436131109, 1526.542037388779, 1540.6687562173963, 1543.413502868925, 1558.844115588432, 32385.190370240933, 32550.674493254763, 33053.834730826195, 33214.335713286084, 33809.49285760765, 52396.0, 53253.73373133109, 53284.0, 53389.0, 53490.0, 456743.0, 458894.0, 459078.0, 460055.0, 460638.0, 29932.551011734406, 30378.39243215079, 30525.23686907845, 30550.541741873447, 30762.692373075985, 48390.27414588854, 48787.0, 48931.75534122306, 49222.0, 49248.50751492583, 41272.79363603163, 41405.171896562504, 41532.1693566133, 42940.785296074566, 42986.35520467133, 39809.0, 40611.593884061964, 40962.38556421596, 41121.38317925174, 41310.38034429426, 42391.57608424, 42752.78623606862, 43005.78497107494, 44513.55486445094, 45732.31401528913, 32227.838860805547, 34283.828580856934, 34702.0, 36157.81921090378, 36435.63564364429, 28447.146585602466, 28692.856535717186, 28753.0, 29103.272418189714, 29311.413771724874], "value": 21056.748732990276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7961609003544, 419.15958503201085, 426.17109721591515, 426.7716771527233, 438.76087532294895, 14669.706605867876, 18576.16407261673, 19259.325923592678, 19317.0, 19332.613347733037, 16029.278682459288, 16253.431129910456, 16281.592960176002, 16791.916040419812, 19035.524111897208, 5696.544276457894, 5901.232839730829, 5914.497267732248, 5917.319508256541, 5925.644461332312, 5655.349634792011, 5906.793262235823, 5924.407559244062, 5952.55355848311, 5990.071538911476, 5849.795257166, 5873.412658734135, 5908.32054313753, 5919.082542205965, 5942.851428714273, 5438.8912221755545, 5671.149327600851, 5681.147827825818, 5693.971530142364, 5703.17303990921, 5352.384475785296, 5547.389787123413, 5549.944500555023, 5600.1599760035915, 5615.578831587606, 13172.802407963889, 13280.601581952556, 13354.532591359255, 17102.914485427493, 21785.455363615878, 2391.175044609607, 2393.8324317297797, 2521.5461216980934, 2705.837649741022, 2964.902985895211, 9534.904650953471, 9701.6604418845, 9743.512824358753, 10213.2850700451, 10239.436830974293, 1981.2471260920902, 2023.3323003408839, 2046.467918341227, 2065.493953981284, 2118.936431907045, 72347.27652723459, 80438.19561804365, 80954.0, 81173.59413202896, 82151.589242054, 11195.664130076111, 11476.368799716096, 11495.3677547734, 11642.476088576035, 11761.353125578175, 16442.588935276715, 16540.0, 16546.751798722787, 16551.420700275434, 16580.917095414687, 8729.607167677343, 8749.387542872066, 8765.07966663504, 8820.294376449869, 8942.687005954891, 8555.401121921406, 8835.0, 8852.38033337673, 8886.51124188163, 8957.731268061969, 4626.86119416418, 4748.453927798348, 4859.805607775649, 4952.925706114411, 5017.724025178651, 1958.8628795984143, 2119.6184686756533, 2127.1597718901257, 2166.1985065525855, 2182.454386403399, 1022.7392015036119, 1044.556063672936, 1112.360392774158, 1113.1540029577418, 1118.6308518188978, 18617.348392806456, 19025.238990440226, 19261.807381926003, 19526.0, 19910.303139390053, 1046.5499835070993, 1086.3264775838873, 1104.8784633690289, 1111.8832522585012, 1139.743557699511, 10786.892131078746, 11074.723131921604, 11144.33134011962, 11229.27009744364, 11231.382273974847, 523142.0, 529541.0, 536503.0, 536780.0, 537406.0, 91259.0, 91469.0, 92700.53649731708, 94202.0, 94297.0835541245, 1095.4194277033184, 1096.8848270931596, 1151.83874257604, 1161.35544772652, 1182.6688527212393, 17137.571560711083, 17480.12599370001, 17602.207900644247, 17648.205830737905, 17987.0, 39034.2193156141, 39094.609053909095, 39629.603703963745, 39683.2063358737, 41224.175516490104, 58275.0, 58281.70859145677, 58578.70710646419, 58773.706131469065, 58965.410345895994, 8573.528455934984, 8637.481751094954, 8696.478211307342, 8809.251213646912, 8861.113888611088, 12322.445489952794, 12966.22202667843, 13100.541481048118, 13244.404001820134, 13519.459221631418, 11495.8275625864, 11731.47208375608, 11970.22193557416, 12266.75466490683, 12307.56923507673, 6124.724387402489, 8608.62262038071, 11448.198626096426, 12243.387830608612, 12323.198992065487, 12151.149419540547, 12352.62942111738, 12474.126811123135, 12548.874511254771, 12763.106582539132, 8639.784005399915, 8683.739487815375, 8721.302295816193, 8781.51701656415, 8789.780255493664, 11744.119191060534, 12330.63008109758, 12438.937805310916, 12483.251004939733, 12544.121911466109], "value": 9350.325560218851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.1491737003334, 1561.9375224991002, 1780.4895097911947, 1859.5351162209456, 1898.591802762406, 7377.88933166003, 7988.400869934763, 8065.2741253287195, 8241.093479717227, 8258.42191046627, 8402.957985210065, 8442.409031367806, 8491.745247642566, 8520.275776558985, 8545.102764209762, 2257.1084421653477, 2281.133169395627, 2282.052948026567, 2283.8058765004994, 2286.451251699597, 2248.347979086063, 2265.444965983328, 2268.9319320420414, 2283.212291759349, 2291.2667946257206, 2249.8200143988524, 2272.0, 2283.4291427143216, 2294.7475777664527, 2296.8047715944167, 2259.344790010895, 2293.6330187170056, 2297.9540409191804, 2299.379167624749, 2303.896324665394, 2100.705901173837, 2132.3176583493287, 2134.9146034158616, 2136.9893150534303, 2138.4012476506605, 8557.358198135102, 8573.785655358604, 8575.056743758181, 8638.697645582375, 8669.739907802776, 5245.0, 5342.572594192494, 5357.946420535784, 5370.650907691027, 5379.542738867201, 3346.5649465569563, 3435.9656403435897, 3547.4146765783617, 3569.5894972078286, 3592.4252119660728, 1117.3854380090918, 1128.136975213962, 1166.632510759108, 1186.2052424875353, 1193.3675152169365, 12102.0, 12186.81719774213, 12200.0, 12207.572734954234, 12220.388980550937, 4493.820247190141, 4553.066621342617, 4588.0, 4590.104929538775, 4632.351470794091, 9596.280278978966, 9613.230941524662, 9624.711258662112, 9638.566264518113, 9652.662156824477, 5229.581633469314, 5231.450697676765, 5237.423883372826, 5247.475252474722, 5265.21021846726, 4726.834560790356, 4839.637027222972, 4860.1008813369635, 4866.489018653061, 4877.244027175793, 3843.385058390644, 3898.941515877264, 3951.565327813938, 3963.841446342172, 3972.066564357374, 1180.504188240941, 1186.4364426897328, 1209.6492017314881, 1217.9512819487122, 1221.145198361133, 954.2270760683869, 987.2891518106951, 1009.1472705563787, 1015.1067060986285, 1041.9166466682648, 5762.538996880239, 5783.16144159103, 5830.038043722739, 5880.500157486576, 5942.227510423617, 941.9670311539063, 983.5033308179467, 1077.385890042668, 1077.8544896439037, 1109.57836022311, 3858.2476417098956, 4068.5727998559723, 4110.34234522481, 4177.143685544456, 4204.558521355275, 9829.361091529028, 9927.453990030474, 10175.745606359753, 10225.846612300822, 10560.313579617301, 10702.090322322534, 10826.40454774995, 10861.239713220157, 10931.398773067558, 10951.123910087334, 8234.835303293901, 8241.752747417468, 8396.664133434595, 8444.535550544657, 8513.787155321166, 5504.6421982571, 5539.8892022160135, 5625.437456254342, 5697.6296540724725, 5716.056850619601, 9632.325737198329, 9672.70981870545, 9756.365836220622, 9762.219022478326, 9835.262355323237, 9369.25045996305, 9557.665481708107, 9959.103680668775, 10026.94986525092, 10036.297459177787, 6626.171728533934, 6808.489363297872, 6977.1278590176225, 7187.928120718935, 7303.817404564716, 7831.530108193527, 7831.647575859214, 7833.1775163607, 7854.253845884632, 7930.801729956566, 6787.321267873371, 7066.964665176847, 7165.964170179116, 7198.0, 7229.891551626624, 7006.2643422439905, 7018.473614478832, 7060.611666358194, 7125.0, 7150.392216661642, 6794.966025169842, 6838.14523184602, 6887.139107611549, 6892.241853396022, 6904.4131248844415, 5127.256547800623, 5137.17805151174, 5143.408508021475, 5144.614153938394, 5178.792848286026, 4926.433460152129, 4972.428170760409, 4976.129177394014, 4981.327520784647, 4991.5008499151245], "value": 4547.041936290375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5732170769101, 346.4664416798131, 350.56179775280896, 355.9448285515743, 357.5530586766542, 6683.966580167104, 6692.0, 6752.054712340277, 6765.627890466022, 6791.456683465317, 6584.802455926318, 6604.2074951005825, 6634.104395906551, 6638.73445062197, 6657.866842663144, 4821.397325334333, 4999.0, 5001.099802035632, 5007.0, 5015.3730783652045, 4925.802967881298, 4930.161872481687, 4930.852074437755, 4931.2603109533675, 4948.554630083292, 4852.781624826891, 4860.368152140217, 4914.311996320518, 4933.7286449245275, 4936.851894443173, 4937.580305673986, 4940.629452791037, 4947.950520494803, 4954.554090131869, 4956.231784073474, 4278.935815962763, 4283.978580107079, 4284.742915425085, 4288.078063216392, 4289.270823959903, 6390.233172019387, 6403.103565500834, 6413.390727880844, 6414.775482858125, 6418.1656384669695, 5653.717314134318, 5698.287714035746, 5765.365809760923, 5767.106098554731, 5784.219130417382, 6971.58170509771, 7024.578525288448, 7028.753993610199, 7046.5067445278855, 7047.612381319025, 4688.68716759308, 4694.600958918496, 4731.550502702238, 4735.479097299294, 4739.478657347689, 7281.5631062136445, 7283.053203083618, 7304.780856574312, 7320.084989376328, 7364.079490063742, 4725.834595789131, 4762.3808904842845, 4763.499832517605, 4772.904541909143, 4778.1638213312535, 4697.389339385858, 4836.274558816206, 4847.927281090787, 4856.465788763233, 4884.975575122173, 5690.6870122142855, 5716.714164291852, 5724.0, 5724.084146536534, 5731.742071606787, 6946.9579563065945, 6975.9302406975285, 7050.541714788523, 7052.118485189351, 7057.082579264663, 1689.3580439432938, 1713.9143042847809, 1714.9742753858702, 1715.5625315544457, 1723.9482815515555, 1029.1920842138884, 1057.8095942730383, 1075.9031687148195, 1087.4019289390803, 1101.6364599682086, 6815.250322464525, 6856.588604683735, 6859.07402500656, 6860.656967151623, 6870.45036397087, 7279.963600181965, 7328.413726901835, 7329.853402932018, 7339.266073392618, 7351.154617219088, 6731.966340168267, 6848.212455567574, 6855.177378714586, 6860.211075726355, 6965.442764578822, 3983.661388781986, 4005.7796821174534, 4026.879193624196, 4027.335489644176, 4035.9394609080887, 7666.080070391588, 7699.653515591812, 7727.111382191008, 7734.4585878989055, 7736.071671399468, 7515.8496830063095, 7534.924650753423, 7540.547567145989, 7563.432742544222, 7595.772126836204, 7410.814729631802, 7689.961550192325, 7690.961545192238, 7703.768886933401, 7710.421718371144, 7307.41540676734, 7322.560646361236, 7364.742234021784, 7373.33639972405, 7374.151972523228, 7197.784066477804, 7230.783076507713, 7238.6018768968215, 7247.311505406978, 7261.963690181516, 7684.46208765381, 7691.923080769345, 7712.421568382281, 7715.112762032438, 7722.459427839997, 4555.066211426583, 4665.603423708887, 4669.089527542097, 4717.457492388419, 4823.782929768098, 7263.818404539928, 7317.26827317264, 7317.853642927218, 7334.853302933805, 7336.889946650911, 7063.752768653072, 7109.289071093056, 7144.892826607709, 7146.678399471933, 7147.606881621561, 7037.366637002694, 7040.471964602573, 7067.222605513287, 7077.433805295461, 7083.893741593984, 6808.625525595941, 6934.583924964519, 6969.2682268361095, 6978.825529361604, 6983.987321838204, 7109.75115870942, 7112.182099058675, 7127.180374257026, 7152.85694286101, 7158.785236442915, 6925.93074069273, 6968.65156742171, 6970.825729356604, 6973.16322041338, 6992.2308546058875], "value": 5259.488877814023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.7175202803005, 864.3042350907521, 918.7565295196772, 939.844925587278, 950.5199874063596, 13657.863421365784, 14306.928465357658, 14309.856901430983, 14317.57047288583, 14401.0, 13785.586432407019, 13841.238731869744, 13927.164370137798, 13944.233067181302, 13945.233012184326, 915.8763566918481, 923.2475532441073, 933.8645896345059, 937.9062093790601, 946.0917519181594, 919.8482250428672, 926.5645146781002, 935.4854829843558, 936.0358830404695, 936.9906300937006, 967.569431602937, 968.5544649461257, 974.6978436684615, 979.6522234606718, 982.086659406755, 957.5260246178117, 962.3888830592554, 968.5157421289356, 968.9854652180223, 971.3637567393333, 714.4391652552721, 714.7819914925946, 715.5134508534195, 717.4654882112807, 720.7369310201739, 15325.386984520606, 15337.0, 15444.073355598588, 15456.845431545766, 15470.845291547053, 13725.45098196071, 13927.860721392757, 14233.28833558318, 14264.643383915381, 14447.133172009608, 11687.474063667156, 11737.413129343498, 12218.694532636666, 12263.325517096557, 12398.256104633661, 3947.940780888289, 4006.4791577094793, 4042.090529630839, 4059.7361171523758, 4118.135191609766, 57490.13764793531, 57561.13658295129, 57652.42347576513, 58748.706256468875, 59118.0, 11174.888251117547, 11249.550017999189, 11270.7182320441, 11314.434278286053, 11435.656930292105, 20328.593428131353, 20638.58722825535, 20682.896585516977, 20764.0, 20843.895780521303, 8608.09614990417, 8778.034416214212, 8815.426997245158, 8934.642614295355, 8976.640934362553, 4908.2146856503505, 4973.676711013845, 4982.427020892571, 5055.090083784954, 5153.974230128901, 3611.223586928823, 3634.309481198564, 3635.327464419091, 3635.472856435802, 3644.7448678592773, 624.7313655128247, 643.9581427207216, 661.4897900488916, 665.3845193196274, 669.5547460938421, 782.9530228186327, 784.2471227621547, 799.4923223752959, 824.686619084756, 834.6995081770558, 9573.473458959685, 9712.125908668253, 9757.170640495495, 9855.75360615976, 9871.30900836949, 630.8801327747805, 745.0947099274408, 745.9664315105833, 753.3408267765705, 756.0964647246598, 4533.569310915458, 4628.39830821991, 4777.140114779304, 4808.567228949411, 4892.535209155125, 61515.38484615186, 63307.6834615824, 67570.32429675739, 67919.0, 67980.32019679839, 53228.73385633047, 53340.46659533433, 54072.91854162973, 54297.45702543003, 57597.712011439675, 52136.739316303174, 54406.53129579243, 54479.18281225706, 54496.45503544914, 54820.45179548153, 9642.951785241028, 10011.699649010541, 10057.69826905194, 10094.697159085239, 10100.6574156283, 36893.631063690096, 38152.809235953646, 38625.0, 39345.0, 39607.40588891227, 42328.365074524525, 48095.5190448091, 50073.499265008344, 50095.74952125216, 50651.746741266055, 12194.878051219373, 12235.265884046985, 12588.181768185039, 12685.112042156961, 12835.871641283467, 13621.114627549177, 14125.152490850582, 14137.787933180805, 14152.292385380895, 14872.925635371754, 12302.75394492123, 12351.313009057387, 12476.937615311865, 12653.240805551697, 12673.0, 11906.940465297965, 12387.380630968595, 12559.37203139821, 12908.870911290767, 13321.467141314239, 12169.2698438094, 13042.282674452996, 13066.216027038408, 13081.542146024844, 13086.280254585708, 10899.945500272448, 10913.727156821144, 11145.442727863736, 11188.66434006981, 11219.046381057702, 11204.327740335606, 11209.71975700614, 11261.71845703864, 11361.204715669825, 11376.488058037243], "value": 7186.087214497737, "unit": "score"}], "name": "dromaeo_css", "value": 7535.262382956906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 104.0, 109.0, 112.0, 110.0, 102.0, 111.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 151.0, 170.0, 127.0, 152.0, 154.0, 129.0, 191.0, 132.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 164.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 174.0, 74.0, 76.0, 75.0, 75.0, 159.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 145.0, 91.0, 92.0, 92.0, 151.0, 93.0, 93.0, 144.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 79.0, 54.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 74.0, 73.0, 82.0, 74.0, 76.0, 74.0, 74.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 116.0, 112.0, 116.0, 132.0, 117.0, 113.0, 115.0, 133.0, 129.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 160.0, 163.0, 163.0, 161.0, 172.0, 160.0, 162.0, 158.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 68.0, 68.0, 67.0, 66.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1523.3, "alertThreshold": 2.0}]} 03:53:13 INFO - Return code: 0 03:53:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:53:14 ERROR - # TBPL SUCCESS # 03:53:14 INFO - Running post-action listener: _resource_record_post_action 03:53:14 INFO - Running post-run listener: _resource_record_post_run 03:53:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8060928; Write bytes: 467886080; Read time: 2188; Write time: 509020 03:53:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 83415040; Read time: 0; Write time: 71896 03:53:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6324224; Write bytes: 384471040; Read time: 2148; Write time: 437124 03:53:15 INFO - Running post-run listener: _upload_blobber_files 03:53:15 INFO - Blob upload gear active. 03:53:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:15 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 03:53:15 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'] 03:53:15 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 03:53:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:16 INFO - (blobuploader) - INFO - Done attempting. 03:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:17 INFO - (blobuploader) - INFO - Done attempting. 03:53:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:17 INFO - Return code: 0 03:53:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0daffd39e2228d854208ea65f75d62815be27b7f770d3e74cf7ba9ff7dd097c45f017c823c9c34205ecb4a1885811dc6e8bcab5e947c5dbe1ccef34d58e39fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a89dae63026dda1baf2adfa113d84db0b74d6832e9c960f8d492a33c7cb13ef8386adc84e2f0c416e5b61ae72462484f7c505fd11ac11f5971c8df90992c648a"} 03:53:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:17 INFO - Contents: 03:53:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0daffd39e2228d854208ea65f75d62815be27b7f770d3e74cf7ba9ff7dd097c45f017c823c9c34205ecb4a1885811dc6e8bcab5e947c5dbe1ccef34d58e39fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a89dae63026dda1baf2adfa113d84db0b74d6832e9c960f8d492a33c7cb13ef8386adc84e2f0c416e5b61ae72462484f7c505fd11ac11f5971c8df90992c648a"} 03:53:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:17 INFO - Copying logs to upload dir... 03:53:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.499848 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-22 03:53:17.133280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 03:53:17.137002) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0daffd39e2228d854208ea65f75d62815be27b7f770d3e74cf7ba9ff7dd097c45f017c823c9c34205ecb4a1885811dc6e8bcab5e947c5dbe1ccef34d58e39fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a89dae63026dda1baf2adfa113d84db0b74d6832e9c960f8d492a33c7cb13ef8386adc84e2f0c416e5b61ae72462484f7c505fd11ac11f5971c8df90992c648a"} build_url:https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/JWd0GUn1TBqHpxR4R4jmyQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0daffd39e2228d854208ea65f75d62815be27b7f770d3e74cf7ba9ff7dd097c45f017c823c9c34205ecb4a1885811dc6e8bcab5e947c5dbe1ccef34d58e39fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a89dae63026dda1baf2adfa113d84db0b74d6832e9c960f8d492a33c7cb13ef8386adc84e2f0c416e5b61ae72462484f7c505fd11ac11f5971c8df90992c648a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 03:53:17.166859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:53:17.167189) ========= 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=5bd038846534b2fdfa68eeae000001e2-1463899881.53888-271220685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 03:53:17.253212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 03:53:17.253938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 03:53:17.254634) ========= ========= Total master_lag: 0.18 =========