builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1464430281.58 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.578153) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.578746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.579154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.594905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.595288) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:11:22-- 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% 222M=0s 2016-05-28 03:11:22 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.692260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.692729) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017618 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:21.743202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:21.743563) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:11:22,299 truncating revision to first 12 chars 2016-05-28 03:11:22,299 Setting DEBUG logging. 2016-05-28 03:11:22,299 attempt 1/10 2016-05-28 03:11:22,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:11:23,141 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:22.937656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:22.937986) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:22.938381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:22.938664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:22.949002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-28 03:11:22.949275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:23 INFO - MultiFileLogger online at 20160528 03:11:23 in /builds/slave/test 03:11:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:23 INFO - {'append_to_log': False, 03:11:23 INFO - 'base_work_dir': '/builds/slave/test', 03:11:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:23 INFO - 'branch': 'Mozilla-Aurora', 03:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:23 INFO - 'config_files': ('talos/linux_config.py',), 03:11:23 INFO - 'default_actions': ('clobber', 03:11:23 INFO - 'read-buildbot-config', 03:11:23 INFO - 'download-and-extract', 03:11:23 INFO - 'populate-webroot', 03:11:23 INFO - 'create-virtualenv', 03:11:23 INFO - 'install', 03:11:23 INFO - 'run-tests'), 03:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:23 INFO - 'download_minidump_stackwalk': True, 03:11:23 INFO - 'download_symbols': 'ondemand', 03:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:23 INFO - 'installer_path': 'installer.exe', 03:11:23 INFO - 'log_level': 'info', 03:11:23 INFO - 'log_name': 'talos', 03:11:23 INFO - 'log_to_console': True, 03:11:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:23 INFO - 'opt_config_files': (), 03:11:23 INFO - 'pip_index': False, 03:11:23 INFO - 'sps_profile': False, 03:11:23 INFO - 'sps_profile_interval': 0, 03:11:23 INFO - 'suite': 'dromaeojs', 03:11:23 INFO - 'system_bits': '32', 03:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:23 INFO - 'title': 'talos-linux64-ix-010', 03:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:23 INFO - 'use_talos_json': True, 03:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:23 INFO - 'work_dir': 'build'} 03:11:23 INFO - ##### 03:11:23 INFO - ##### Running clobber step. 03:11:23 INFO - ##### 03:11:23 INFO - Running pre-action listener: _resource_record_pre_action 03:11:23 INFO - Running main action method: clobber 03:11:23 INFO - rmtree: /builds/slave/test/build 03:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:24 INFO - Running post-action listener: _resource_record_post_action 03:11:24 INFO - ##### 03:11:24 INFO - ##### Running read-buildbot-config step. 03:11:24 INFO - ##### 03:11:24 INFO - Running pre-action listener: _resource_record_pre_action 03:11:24 INFO - Running main action method: read_buildbot_config 03:11:24 INFO - Using buildbot properties: 03:11:24 INFO - { 03:11:24 INFO - "project": "", 03:11:24 INFO - "product": "firefox", 03:11:24 INFO - "script_repo_revision": "production", 03:11:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:11:24 INFO - "repository": "", 03:11:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:11:24 INFO - "buildid": "20160525152143", 03:11:24 INFO - "pgo_build": "True", 03:11:24 INFO - "basedir": "/builds/slave/test", 03:11:24 INFO - "buildnumber": 264, 03:11:24 INFO - "slavename": "talos-linux64-ix-010", 03:11:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:11:24 INFO - "platform": "ubuntu64_hw", 03:11:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:11:24 INFO - "branch": "mozilla-aurora", 03:11:24 INFO - "repo_path": "releases/mozilla-aurora", 03:11:24 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 03:11:24 INFO - "stage_platform": "linux64-pgo", 03:11:24 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 03:11:24 INFO - "slavebuilddir": "test" 03:11:24 INFO - } 03:11:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:11:24 INFO - Running post-action listener: _resource_record_post_action 03:11:24 INFO - ##### 03:11:24 INFO - ##### Running download-and-extract step. 03:11:24 INFO - ##### 03:11:24 INFO - Running pre-action listener: _resource_record_pre_action 03:11:24 INFO - Running main action method: download_and_extract 03:11:24 INFO - mkdir: /builds/slave/test/build/tests 03:11:24 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:11:24 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:24 INFO - Downloaded 1361 bytes. 03:11:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:24 INFO - Using the following test package requirements: 03:11:24 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:24 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:11:24 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:11:24 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'jsshell-linux-x86_64.zip'], 03:11:24 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:11:24 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:24 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:11:24 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:11:24 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:11:24 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:24 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:11:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:11:24 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:11:24 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:26 INFO - Downloaded 24135950 bytes. 03:11:26 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:11:26 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:11:27 INFO - Return code: 0 03:11:27 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:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:27 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:28 INFO - Downloaded 24135950 bytes. 03:11:28 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:11:28 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:11:29 INFO - Return code: 0 03:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:29 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:30 INFO - Downloaded 10840145 bytes. 03:11:30 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:11:30 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:11:31 INFO - Return code: 0 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:31 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:32 INFO - Downloaded 62768089 bytes. 03:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:32 INFO - mkdir: /builds/slave/test/properties 03:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:32 INFO - Contents: 03:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:34 INFO - Running post-action listener: _resource_record_post_action 03:11:34 INFO - Running post-action listener: set_extra_try_arguments 03:11:34 INFO - ##### 03:11:34 INFO - ##### Running populate-webroot step. 03:11:34 INFO - ##### 03:11:34 INFO - Running pre-action listener: _resource_record_pre_action 03:11:34 INFO - Running main action method: populate_webroot 03:11:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:34 INFO - '--tppagecycles', 03:11:34 INFO - '7'], 03:11:34 INFO - 'tests': ['tsvgm']}}, 03:11:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['damp', 'tps']}, 03:11:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'tests': ['damp', 'tps']}, 03:11:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['dromaeo_dom']}, 03:11:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['a11yr', 03:11:34 INFO - 'ts_paint', 03:11:34 INFO - 'tpaint', 03:11:34 INFO - 'sessionrestore', 03:11:34 INFO - 'sessionrestore_no_auto_restore', 03:11:34 INFO - 'tabpaint']}, 03:11:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['tsvgx', 03:11:34 INFO - 'tsvgr_opacity', 03:11:34 INFO - 'tart', 03:11:34 INFO - 'tscrollx', 03:11:34 INFO - 'cart']}, 03:11:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:34 INFO - 'tsvgr_opacity', 03:11:34 INFO - 'tart', 03:11:34 INFO - 'tscrollx', 03:11:34 INFO - 'cart']}, 03:11:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'talos_options': ['--disable-e10s'], 03:11:34 INFO - 'tests': ['tp5o']}, 03:11:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'tests': ['tp5o']}, 03:11:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'talos_options': ['--disable-e10s', 03:11:34 INFO - '--xperf_path', 03:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:34 INFO - 'tests': ['tp5n']}, 03:11:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:34 INFO - 'talos_options': ['--xperf_path', 03:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:34 INFO - 'tests': ['tp5n']}}, 03:11:34 INFO - 'talos.zip': {'path': '', 03:11:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:34 INFO - Running post-action listener: _resource_record_post_action 03:11:34 INFO - ##### 03:11:34 INFO - ##### Running create-virtualenv step. 03:11:34 INFO - ##### 03:11:34 INFO - Running pre-action listener: _resource_record_pre_action 03:11:34 INFO - Running main action method: create_virtualenv 03:11:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:34 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:11:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:34 INFO - Using real prefix '/usr' 03:11:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:37 INFO - Installing pip.................done. 03:11:37 INFO - Return code: 0 03:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:37 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:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:37 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:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:37 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:37 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:11:37 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:11:37 INFO - Using env: {'DISPLAY': ':0', 03:11:37 INFO - 'HOME': '/home/cltbld', 03:11:37 INFO - 'LANG': 'en_US.UTF-8', 03:11:37 INFO - 'LANGUAGE': 'en_US:en', 03:11:37 INFO - 'LOGNAME': 'cltbld', 03:11:37 INFO - 'MAIL': '/var/mail/cltbld', 03:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:37 INFO - 'MOZ_NO_REMOTE': '1', 03:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:37 INFO - 'NO_EM_RESTART': '1', 03:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:37 INFO - 'PWD': '/builds/slave/test', 03:11:37 INFO - 'SHELL': '/bin/bash', 03:11:37 INFO - 'SHLVL': '1', 03:11:37 INFO - 'TERM': 'linux', 03:11:37 INFO - 'TMOUT': '86400', 03:11:37 INFO - 'USER': 'cltbld', 03:11:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:37 INFO - '_': '/tools/buildbot/bin/python'} 03:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:37 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:11:37 INFO - Cleaning up... 03:11:37 INFO - Return code: 0 03:11:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11:37 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:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:37 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:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:37 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:37 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:11:37 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:11:37 INFO - Using env: {'DISPLAY': ':0', 03:11:37 INFO - 'HOME': '/home/cltbld', 03:11:37 INFO - 'LANG': 'en_US.UTF-8', 03:11:37 INFO - 'LANGUAGE': 'en_US:en', 03:11:37 INFO - 'LOGNAME': 'cltbld', 03:11:37 INFO - 'MAIL': '/var/mail/cltbld', 03:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:37 INFO - 'MOZ_NO_REMOTE': '1', 03:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:37 INFO - 'NO_EM_RESTART': '1', 03:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:37 INFO - 'PWD': '/builds/slave/test', 03:11:37 INFO - 'SHELL': '/bin/bash', 03:11:37 INFO - 'SHLVL': '1', 03:11:37 INFO - 'TERM': 'linux', 03:11:37 INFO - 'TMOUT': '86400', 03:11:37 INFO - 'USER': 'cltbld', 03:11:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:37 INFO - '_': '/tools/buildbot/bin/python'} 03:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:37 INFO - Downloading/unpacking psutil>=0.7.1 03:11:37 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:11:37 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:11:37 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:11:37 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:11:37 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:11:37 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:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:39 INFO - Installing collected packages: psutil 03:11:39 INFO - Running setup.py install for psutil 03:11:39 INFO - building 'psutil._psutil_linux' extension 03:11:39 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:11:39 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:11:40 INFO - building 'psutil._psutil_posix' extension 03:11:40 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:11:40 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:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:40 INFO - Successfully installed psutil 03:11:40 INFO - Cleaning up... 03:11:40 INFO - Return code: 0 03:11:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11:40 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:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 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:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:40 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:40 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:11:40 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:11:40 INFO - Using env: {'DISPLAY': ':0', 03:11:40 INFO - 'HOME': '/home/cltbld', 03:11:40 INFO - 'LANG': 'en_US.UTF-8', 03:11:40 INFO - 'LANGUAGE': 'en_US:en', 03:11:40 INFO - 'LOGNAME': 'cltbld', 03:11:40 INFO - 'MAIL': '/var/mail/cltbld', 03:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:40 INFO - 'MOZ_NO_REMOTE': '1', 03:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:40 INFO - 'NO_EM_RESTART': '1', 03:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:40 INFO - 'PWD': '/builds/slave/test', 03:11:40 INFO - 'SHELL': '/bin/bash', 03:11:40 INFO - 'SHLVL': '1', 03:11:40 INFO - 'TERM': 'linux', 03:11:40 INFO - 'TMOUT': '86400', 03:11:40 INFO - 'USER': 'cltbld', 03:11:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:40 INFO - '_': '/tools/buildbot/bin/python'} 03:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:42 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:11:42 INFO - Installing collected packages: mozsystemmonitor 03:11:42 INFO - Running setup.py install for mozsystemmonitor 03:11:42 INFO - Successfully installed mozsystemmonitor 03:11:42 INFO - Cleaning up... 03:11:42 INFO - Return code: 0 03:11:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:42 INFO - Using env: {'DISPLAY': ':0', 03:11:42 INFO - 'HOME': '/home/cltbld', 03:11:42 INFO - 'LANG': 'en_US.UTF-8', 03:11:42 INFO - 'LANGUAGE': 'en_US:en', 03:11:42 INFO - 'LOGNAME': 'cltbld', 03:11:42 INFO - 'MAIL': '/var/mail/cltbld', 03:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:42 INFO - 'MOZ_NO_REMOTE': '1', 03:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:42 INFO - 'NO_EM_RESTART': '1', 03:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:42 INFO - 'PWD': '/builds/slave/test', 03:11:42 INFO - 'SHELL': '/bin/bash', 03:11:42 INFO - 'SHLVL': '1', 03:11:42 INFO - 'TERM': 'linux', 03:11:42 INFO - 'TMOUT': '86400', 03:11:42 INFO - 'USER': 'cltbld', 03:11:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:42 INFO - '_': '/tools/buildbot/bin/python'} 03:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:44 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:11:44 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:11:44 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:11:44 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:11:44 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:11:44 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:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:45 INFO - Downloading docopt-0.6.1.tar.gz 03:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:45 INFO - Running setup.py install for blobuploader 03:11:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:45 INFO - Running setup.py install for requests 03:11:45 INFO - Running setup.py install for docopt 03:11:45 INFO - Successfully installed blobuploader requests docopt 03:11:45 INFO - Cleaning up... 03:11:46 INFO - Return code: 0 03:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:46 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:46 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:11:46 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:11:46 INFO - Using env: {'DISPLAY': ':0', 03:11:46 INFO - 'HOME': '/home/cltbld', 03:11:46 INFO - 'LANG': 'en_US.UTF-8', 03:11:46 INFO - 'LANGUAGE': 'en_US:en', 03:11:46 INFO - 'LOGNAME': 'cltbld', 03:11:46 INFO - 'MAIL': '/var/mail/cltbld', 03:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:46 INFO - 'MOZ_NO_REMOTE': '1', 03:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:46 INFO - 'NO_EM_RESTART': '1', 03:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:46 INFO - 'PWD': '/builds/slave/test', 03:11:46 INFO - 'SHELL': '/bin/bash', 03:11:46 INFO - 'SHLVL': '1', 03:11:46 INFO - 'TERM': 'linux', 03:11:46 INFO - 'TMOUT': '86400', 03:11:46 INFO - 'USER': 'cltbld', 03:11:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:46 INFO - '_': '/tools/buildbot/bin/python'} 03:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:46 INFO - Running setup.py (path:/tmp/pip-bwb1bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:46 INFO - Running setup.py (path:/tmp/pip-g1f5HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:46 INFO - Running setup.py (path:/tmp/pip-z_sCWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:46 INFO - Running setup.py (path:/tmp/pip-unlz6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:46 INFO - Running setup.py (path:/tmp/pip-v0nHfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:46 INFO - Running setup.py (path:/tmp/pip-V0Y6bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:46 INFO - Running setup.py (path:/tmp/pip-G1EeYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:46 INFO - Running setup.py (path:/tmp/pip-YBQwyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:46 INFO - Running setup.py (path:/tmp/pip-Bxlkgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:46 INFO - Running setup.py (path:/tmp/pip-PwAlta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:46 INFO - Running setup.py (path:/tmp/pip-8fDlGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:47 INFO - Running setup.py (path:/tmp/pip-JboncL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:47 INFO - Running setup.py (path:/tmp/pip-OtzRIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:47 INFO - Running setup.py (path:/tmp/pip-bOks1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:47 INFO - Running setup.py (path:/tmp/pip-OeohgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:47 INFO - Running setup.py (path:/tmp/pip-HysxNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:47 INFO - Running setup.py (path:/tmp/pip-MphuSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:47 INFO - Running setup.py install for manifestparser 03:11:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:47 INFO - Running setup.py install for mozcrash 03:11:47 INFO - Running setup.py install for mozdebug 03:11:47 INFO - Running setup.py install for mozdevice 03:11:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:47 INFO - Running setup.py install for mozfile 03:11:48 INFO - Running setup.py install for mozhttpd 03:11:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozinfo 03:11:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozInstall 03:11:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozleak 03:11:48 INFO - Running setup.py install for mozlog 03:11:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for moznetwork 03:11:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozprocess 03:11:48 INFO - Running setup.py install for mozprofile 03:11:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozrunner 03:11:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Running setup.py install for mozscreenshot 03:11:49 INFO - Running setup.py install for moztest 03:11:49 INFO - Running setup.py install for mozversion 03:11:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:49 INFO - Cleaning up... 03:11:49 INFO - Return code: 0 03:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:49 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:49 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:11:49 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:11:49 INFO - Using env: {'DISPLAY': ':0', 03:11:49 INFO - 'HOME': '/home/cltbld', 03:11:49 INFO - 'LANG': 'en_US.UTF-8', 03:11:49 INFO - 'LANGUAGE': 'en_US:en', 03:11:49 INFO - 'LOGNAME': 'cltbld', 03:11:49 INFO - 'MAIL': '/var/mail/cltbld', 03:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:49 INFO - 'MOZ_NO_REMOTE': '1', 03:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:49 INFO - 'NO_EM_RESTART': '1', 03:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:49 INFO - 'PWD': '/builds/slave/test', 03:11:49 INFO - 'SHELL': '/bin/bash', 03:11:49 INFO - 'SHLVL': '1', 03:11:49 INFO - 'TERM': 'linux', 03:11:49 INFO - 'TMOUT': '86400', 03:11:49 INFO - 'USER': 'cltbld', 03:11:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:49 INFO - '_': '/tools/buildbot/bin/python'} 03:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:49 INFO - Running setup.py (path:/tmp/pip-8LLWY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:49 INFO - Running setup.py (path:/tmp/pip-NqkZH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:49 INFO - Running setup.py (path:/tmp/pip-pZFqrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:49 INFO - Running setup.py (path:/tmp/pip-Hx90Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:49 INFO - Running setup.py (path:/tmp/pip-IyFyb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:49 INFO - Running setup.py (path:/tmp/pip-xUjsI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:49 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:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:49 INFO - Running setup.py (path:/tmp/pip-a4Dby_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:50 INFO - Running setup.py (path:/tmp/pip-ThehSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:50 INFO - Running setup.py (path:/tmp/pip-xnpgMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:50 INFO - Running setup.py (path:/tmp/pip-uItmGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:50 INFO - Running setup.py (path:/tmp/pip-XkE681-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:50 INFO - Running setup.py (path:/tmp/pip-pIA31u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:50 INFO - Running setup.py (path:/tmp/pip-uMmVW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:50 INFO - Running setup.py (path:/tmp/pip-1m7bed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:50 INFO - Running setup.py (path:/tmp/pip-eBUE5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:50 INFO - Running setup.py (path:/tmp/pip-il80pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:50 INFO - Running setup.py (path:/tmp/pip-XShsLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:52 INFO - Downloading blessings-1.6.tar.gz 03:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:52 INFO - Installing collected packages: blessings 03:11:52 INFO - Running setup.py install for blessings 03:11:52 INFO - Successfully installed blessings 03:11:52 INFO - Cleaning up... 03:11:52 INFO - Return code: 0 03:11:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:53 INFO - Reading from file tmpfile_stdout 03:11:53 INFO - Current package versions: 03:11:53 INFO - argparse == 1.2.1 03:11:53 INFO - blessings == 1.6 03:11:53 INFO - blobuploader == 1.2.4 03:11:53 INFO - docopt == 0.6.1 03:11:53 INFO - manifestparser == 1.1 03:11:53 INFO - mozInstall == 1.12 03:11:53 INFO - mozcrash == 0.17 03:11:53 INFO - mozdebug == 0.1 03:11:53 INFO - mozdevice == 0.48 03:11:53 INFO - mozfile == 1.2 03:11:53 INFO - mozhttpd == 0.7 03:11:53 INFO - mozinfo == 0.9 03:11:53 INFO - mozleak == 0.1 03:11:53 INFO - mozlog == 3.1 03:11:53 INFO - moznetwork == 0.27 03:11:53 INFO - mozprocess == 0.22 03:11:53 INFO - mozprofile == 0.28 03:11:53 INFO - mozrunner == 6.11 03:11:53 INFO - mozscreenshot == 0.1 03:11:53 INFO - mozsystemmonitor == 0.0 03:11:53 INFO - moztest == 0.7 03:11:53 INFO - mozversion == 1.4 03:11:53 INFO - psutil == 3.1.1 03:11:53 INFO - requests == 1.2.3 03:11:53 INFO - wsgiref == 0.1.2 03:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:53 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:11:53 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:11:53 INFO - Using env: {'DISPLAY': ':0', 03:11:53 INFO - 'HOME': '/home/cltbld', 03:11:53 INFO - 'LANG': 'en_US.UTF-8', 03:11:53 INFO - 'LANGUAGE': 'en_US:en', 03:11:53 INFO - 'LOGNAME': 'cltbld', 03:11:53 INFO - 'MAIL': '/var/mail/cltbld', 03:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:53 INFO - 'MOZ_NO_REMOTE': '1', 03:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:53 INFO - 'NO_EM_RESTART': '1', 03:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:53 INFO - 'PWD': '/builds/slave/test', 03:11:53 INFO - 'SHELL': '/bin/bash', 03:11:53 INFO - 'SHLVL': '1', 03:11:53 INFO - 'TERM': 'linux', 03:11:53 INFO - 'TMOUT': '86400', 03:11:53 INFO - 'USER': 'cltbld', 03:11:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:53 INFO - '_': '/tools/buildbot/bin/python'} 03:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 INFO - Cleaning up... 03:11:53 INFO - Return code: 0 03:11:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:53 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:53 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:11:53 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:11:53 INFO - Using env: {'DISPLAY': ':0', 03:11:53 INFO - 'HOME': '/home/cltbld', 03:11:53 INFO - 'LANG': 'en_US.UTF-8', 03:11:53 INFO - 'LANGUAGE': 'en_US:en', 03:11:53 INFO - 'LOGNAME': 'cltbld', 03:11:53 INFO - 'MAIL': '/var/mail/cltbld', 03:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:53 INFO - 'MOZ_NO_REMOTE': '1', 03:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:53 INFO - 'NO_EM_RESTART': '1', 03:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:53 INFO - 'PWD': '/builds/slave/test', 03:11:53 INFO - 'SHELL': '/bin/bash', 03:11:53 INFO - 'SHLVL': '1', 03:11:53 INFO - 'TERM': 'linux', 03:11:53 INFO - 'TMOUT': '86400', 03:11:53 INFO - 'USER': 'cltbld', 03:11:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:53 INFO - '_': '/tools/buildbot/bin/python'} 03:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:53 INFO - Downloading/unpacking jsonschema 03:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:53 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:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:55 INFO - warning: no files found matching '*.txt' 03:11:55 INFO - no previously-included directories found matching 'build' 03:11:55 INFO - no previously-included directories found matching 'dist' 03:11:55 INFO - no previously-included directories found matching '.git*' 03:11:55 INFO - Installing collected packages: jsonschema, functools32 03:11:55 INFO - Running setup.py install for functools32 03:11:55 INFO - warning: no files found matching '*.txt' 03:11:55 INFO - no previously-included directories found matching 'build' 03:11:55 INFO - no previously-included directories found matching 'dist' 03:11:55 INFO - no previously-included directories found matching '.git*' 03:11:55 INFO - Successfully installed jsonschema functools32 03:11:55 INFO - Cleaning up... 03:11:55 INFO - Return code: 0 03:11:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:11:55 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:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:55 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:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:55 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 0x7fd15ffeef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', '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:11:55 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:11:55 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:11:55 INFO - Using env: {'DISPLAY': ':0', 03:11:55 INFO - 'HOME': '/home/cltbld', 03:11:55 INFO - 'LANG': 'en_US.UTF-8', 03:11:55 INFO - 'LANGUAGE': 'en_US:en', 03:11:55 INFO - 'LOGNAME': 'cltbld', 03:11:55 INFO - 'MAIL': '/var/mail/cltbld', 03:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:55 INFO - 'MOZ_NO_REMOTE': '1', 03:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:55 INFO - 'NO_EM_RESTART': '1', 03:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:55 INFO - 'PWD': '/builds/slave/test', 03:11:55 INFO - 'SHELL': '/bin/bash', 03:11:55 INFO - 'SHLVL': '1', 03:11:55 INFO - 'TERM': 'linux', 03:11:55 INFO - 'TMOUT': '86400', 03:11:55 INFO - 'USER': 'cltbld', 03:11:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:55 INFO - '_': '/tools/buildbot/bin/python'} 03:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:56 INFO - Downloading/unpacking flake8 03:11:56 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:11:56 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:11:56 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:11:56 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:11:56 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:11:56 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:11:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:11:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:11:57 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:11:57 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:11:57 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:11:57 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:11:57 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:11:57 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:11:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:11:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:58 INFO - no previously-included directories found matching 'docs/_build' 03:11:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:11:58 INFO - Running setup.py install for pep8 03:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:58 INFO - no previously-included directories found matching 'docs/_build' 03:11:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:11:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:11:58 INFO - Cleaning up... 03:11:58 INFO - Return code: 0 03:11:58 INFO - Running post-action listener: _resource_record_post_action 03:11:58 INFO - Running post-action listener: _start_resource_monitoring 03:11:58 INFO - Starting resource monitoring. 03:11:58 INFO - ##### 03:11:58 INFO - ##### Running install step. 03:11:58 INFO - ##### 03:11:58 INFO - Running pre-action listener: _resource_record_pre_action 03:11:58 INFO - Running main action method: install 03:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:59 INFO - Reading from file tmpfile_stdout 03:11:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:59 INFO - Reading from file tmpfile_stdout 03:11:59 INFO - Output received: 03:11:59 INFO - Usage: mozinstall [options] installer 03:11:59 INFO - Options: 03:11:59 INFO - -h, --help show this help message and exit 03:11:59 INFO - -d DEST, --destination=DEST 03:11:59 INFO - Directory to install application into. [default: 03:11:59 INFO - "/builds/slave/test"] 03:11:59 INFO - --app=APP Application being installed. [default: firefox] 03:11:59 INFO - mkdir: /builds/slave/test/build/application 03:11:59 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:11:59 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:12:14 INFO - Reading from file tmpfile_stdout 03:12:14 INFO - Output received: 03:12:14 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:14 INFO - Running post-action listener: _resource_record_post_action 03:12:14 INFO - ##### 03:12:14 INFO - ##### Running run-tests step. 03:12:14 INFO - ##### 03:12:14 INFO - Running pre-action listener: _resource_record_pre_action 03:12:14 INFO - Running main action method: run_tests 03:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:14 INFO - Python 2.7.3 03:12:14 INFO - Return code: 0 03:12:14 INFO - grabbing minidump binary from tooltool 03:12:14 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:12:14 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 0x12be410>, '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 0x12bf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:14 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:12:14 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:12:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:14 INFO - Return code: 0 03:12:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:15 INFO - Return code: 0 03:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:12:15 INFO - Using env: {'DISPLAY': ':0', 03:12:15 INFO - 'HOME': '/home/cltbld', 03:12:15 INFO - 'LANG': 'en_US.UTF-8', 03:12:15 INFO - 'LANGUAGE': 'en_US:en', 03:12:15 INFO - 'LOGNAME': 'cltbld', 03:12:15 INFO - 'MAIL': '/var/mail/cltbld', 03:12:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:15 INFO - 'MOZ_NO_REMOTE': '1', 03:12:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:15 INFO - 'NO_EM_RESTART': '1', 03:12:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:15 INFO - 'PWD': '/builds/slave/test', 03:12:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:15 INFO - 'SHELL': '/bin/bash', 03:12:15 INFO - 'SHLVL': '1', 03:12:15 INFO - 'TERM': 'linux', 03:12:15 INFO - 'TMOUT': '86400', 03:12:15 INFO - 'USER': 'cltbld', 03:12:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567', 03:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:15 INFO - '_': '/tools/buildbot/bin/python'} 03:12:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:12:16 INFO - mozversion application_buildid: 20160525152143 03:12:16 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:16 INFO - mozversion application_name: Firefox 03:12:16 INFO - mozversion application_remotingname: firefox-dev 03:12:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:16 INFO - mozversion application_vendor: Mozilla 03:12:16 INFO - mozversion application_version: 48.0a2 03:12:16 INFO - mozversion platform_buildid: 20160525152143 03:12:16 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:16 INFO - mozversion platform_version: 48.0a2 03:12:16 INFO - using testdate: 1464430336 03:12:16 INFO - actual date: 1464430336 03:12:16 INFO - starting webserver on 'localhost:49023' 03:12:16 INFO - SUITE-START | Running 2 tests 03:12:16 INFO - TEST-START | dromaeo_css 03:12:16 INFO - operating with platform_type : linux_ 03:12:16 INFO - Initialising browser for dromaeo_css test... 03:12:16 INFO - TEST-INFO | started process 10849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_dUDaN/profile http://localhost:49023/getInfo.html) 03:12:20 INFO - PROCESS | 10849 | __metrics Screen width/height:1600/1200 03:12:20 INFO - PROCESS | 10849 | colorDepth:24 03:12:20 INFO - PROCESS | 10849 | Browser inner width/height: 1024/697 03:12:20 INFO - PROCESS | 10849 | __metrics 03:12:21 ERROR - PROCESS | 10849 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:12:22 INFO - TEST-INFO | 10849: exit 0 03:12:22 INFO - Browser initialized. 03:12:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:22 INFO - TEST-INFO | started process 10945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_dUDaN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:34 INFO - PROCESS | 10945 | RSS: Main: 141484032 03:12:34 INFO - PROCESS | 10945 | 03:13:25 INFO - PROCESS | 10945 | 1464430405623 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:15:33 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49023/tests/dromaeo/cssquery-ext.html) 03:15:34 INFO - PROCESS | 10945 | RSS: Main: 251961344 03:15:34 INFO - PROCESS | 10945 | 03:18:36 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-ext.html (next: http://localhost:49023/tests/dromaeo/cssquery-jquery.html) 03:18:37 INFO - PROCESS | 10945 | RSS: Main: 217948160 03:18:37 INFO - PROCESS | 10945 | 03:21:39 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49023/tests/dromaeo/cssquery-mootools.html) 03:21:39 INFO - PROCESS | 10945 | RSS: Main: 214421504 03:21:39 INFO - PROCESS | 10945 | 03:24:41 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49023/tests/dromaeo/cssquery-prototype.html) 03:24:42 INFO - PROCESS | 10945 | RSS: Main: 222556160 03:24:42 INFO - PROCESS | 10945 | 03:27:44 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49023/tests/dromaeo/cssquery-yui.html) 03:27:45 INFO - PROCESS | 10945 | RSS: Main: 213053440 03:27:45 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:49023/tests/dromaeo/cssquery-yui.html (next: http://localhost:49023/tests/dromaeo/cssquery-dojo.html) 03:30:47 INFO - PROCESS | 10945 | RSS: Main: 254943232 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | __start_tp_report 03:30:47 INFO - PROCESS | 10945 | _x_x_mozilla_page_load 03:30:47 INFO - PROCESS | 10945 | _x_x_mozilla_page_load_details 03:30:47 INFO - PROCESS | 10945 | |i|pagename|runs| 03:30:47 INFO - PROCESS | 10945 | |0;dojo.html;3334.566506354174;3406.4719968404906;3409.471531912553;3433.1931995980954;3447.6897079262862;5635.633683810554;5653.349864765553;5654;5659.292588426447;5663.377028526858;5639.492445679888;5666.9433305666935;5674.347450043247;5674.716264186794;5684.204211410406;4866.391701037371;5079.212722028092;5189.065968125736;5240.60695447841;5277.656952298107;5107.591392688576;5140.768665410047;5157.226416037605;5158.871028224287;5166.509181627739;5058.367704036996;5102.770375333119;5128.410232823236;5133.922991155136;5144.09978253806;5043.394792624872;5051.646384753069;5066.82266120684;5067.619928505377;5101.7194054327;4920.360353154067;4967.950320496821;4972.651914365996;4992.725400102993;5027.09512287788;5442.12925931853;5472.634329887131;5524.06090964537;5527.060399732055;5536.806211782568;5887.0580707086665;5900.97049514754;5903.321118071433;5906.084556893688;5907.172995780594;5918.970405147947;6017.7592896284095;6088.208532890741;6124.816255512342;6134.6625935573975;5556.277683901108;5602.38373778884;5605.355384130796;5606;5642.830715078554;6061.181740465069;6104.664243466652;6114.28542962895;6115.205023346936;6117.143599896018;5919.704014799243;5963.701814909237;5981.162637230791;5984.640921544721;5994.130851026664;5955.315138759098;5963.2844058713235;5965.492933100735;5967.522598192134;5971.761129554856;5878.29460464747;5915.822525324247;5921.111833225051;5927.8221653350465;5936.1095835625;5928.67392293428;5960.731767070492;5960.761569537257;5964.254468191476;5997.220361352996;4512.323151527297;4514.864554063383;4523.36672865799;4529.479109902338;4556.270996640588;4011.8796436106963;4034.8587799426878;4057.6145266199665;4081.551029386765;4115.835366585363;5696.857578560486;5717.742701578439;5720.342160651495;5723.742431590588;5725.427457254241;5985.6408615483215;6014.127951447103;6035.366286539938;6038.547108966845;6039.849003774941;5514.5864060195645;5638.689872056994;5646.153077038477;5687.601867869293;5690.174924635905;5104.2343648453025;5128.461511541309;5130.050940576006;5141.048905952411;5156.303898973665;6170.321264660884;6190.288116866618;6192.659403732838;6194.101855230966;6196.411340922696;5918.201042859159;5998.160257563857;6097;6099.9390006099375;6135.785247516315;6182.9269507856525;6270.278917924497;6276.152719382825;6278.937210628018;6279.497640188865;5740.856478588069;5910.615809972338;5946.07835785454;5949.3455719871645;5985.461308482258;5955.553333500092;5990.910136348046;6019.428154325507;6023.789167379296;6057.333693293822;5768.769249229984;5811;5813.244278243801;5813.476787089182;5815.505682017076;5745.166950792195;5746.597738158289;5801.564882633735;5804.100364443518;5857.970710146422;5763;5816.447437493432;5817.127430885401;5828.154917536848;5860.531157507304;5889.882202356014;5896.439838215363;5900.291964964232;5906.468417842415;5931.584789064724;5656.717164141694;5803.216565763568;5808;5819.127130930395;5865.061590145556 03:30:47 INFO - PROCESS | 10945 | |1;ext.html;660.9259952577062;670.9127813384259;676.4250387170903;733.1751779248344;747.8167848877026;35214.29571408573;35760.64239357609;35854.820725896396;35936.101597460074;35975.10062248442;37872.24255514888;38578.22843543127;38602;38613.613863861356;38722.61277387232;8116.188381161866;8799.692010779609;8988.460692358447;10170.237232207577;10364.27450078491;10246.7438314042;10381.792364152712;10384.63653772118;10385.169186465102;10388.272820902539;10393.32443391181;10505.789884202311;10509;10527.315724477923;10529.578816847317;8426.325893928471;10242.897571024268;10316.690499284958;10336.224783141295;10381.688549343531;10201.744956376077;10298.9485052575;10305.587776488932;10321;10393.16854651626;35000;35760;35813.82093089544;35834.46248306277;35836.64163358359;3415.55597772288;3431.8284085795613;3478.2521757821937;3604.6936010439144;3733.253349330145;30665.69334306651;30810.22974425635;31071.37857242865;31122.533162002586;32096.35807283841;4492.168948744493;4580.221362368406;4651.209294419957;4678.906421871544;4714.1985862403135;233422;237034;237460;238043.99999999825;238561;35367.823160884545;36366.63633363633;54769;55731.442685573435;55803.162952555744;34265.828670856485;34417.82791086079;34428.48357274643;34431.073358764785;34447;13772.862271377358;13792.379342929593;14196.503122390666;14393.856061439252;14395;10335.844962325571;10906.563737450413;11040.171987101;11058.723531911766;11071.501782419811;9014.954925225333;9077.909220907706;9078;9143.222826059859;9174.541272936327;3330.084226837639;3344.2141096842224;3351.4135026370286;3355.043812513422;3401.387750204987;998.9450580218157;1007.6221416968637;1034.9689509314733;1062.129054175584;1117.7373317270435;29571.26071848178;30043;30272.54591181134;30574.38851222963;30666.080017599506;1128.430142777892;1133.3086817041599;1135.2677522997785;1140.5722853929776;1148.9655310340704;15772.76340854888;15778.289976951064;15779.28993195309;16111.919440402722;16118.597035074217;461204;465326;465676;466186;466656;52351;52503.47496525062;52899.206511902354;52960.735196324546;53022.204666930025;1210.3403645013489;1313.8817506424468;1321.491225878044;1380.0339762166323;1387.9444822207201;28033.57949630798;28377;28752.42495150127;28831.711682882902;29980.550291745207;45451.31823022591;45698.77150614226;45737.31394029159;46013.539864602266;46166.53833461623;310905;312048;312913;313975;314255;25627.54028206243;26291.737082629694;28485.43029139447;28689.713102868704;29055.85472072626;39366.409503858034;39416.40875386814;39460.802695986335;39744.801275993435;39903.40144897887;33354;33416.66583334136;33436.83281583576;34019.82990085034;34159.829200853834;32974;34037.48943765895;35338.82330588331;35838.820805895804;35875.64124358723;36525.45211821772;36544.08639784026;36857.26285474329;40416.79791601023;41120.79439602783;29117.563236551894;31650.208744781565;32588.674113259513;32634.673653263162;32821.67178328186;25598.488030239663;25752;26008.73991260063;26205.73794262033;26336.473270534865 03:30:47 INFO - PROCESS | 10945 | |2;jquery.html;385.81095263320975;398.5496389080339;399.57445320733416;402.4164960806829;404.7814180342615;14328.713425731505;15070.020448670855;17358.652826943453;17863.19615617297;17876.284948602057;16074.59813504663;16341.5914602135;16361.100139492353;16366.590835229124;16728.16359182039;5715.5427565794635;5820.621659592113;5849.502792262663;5875.529957603381;5876.529877609781;4304.354346847982;5843.2403787507565;5887.205227294303;6213.316535181127;6457.580257283285;6306.873862522747;6321.841953951165;6350.555461117724;6403.935960640404;6418.711157997878;6144.969275153596;6269.216347956505;6288.779892703757;6325.146105275775;6348.460380867632;5626.915596266059;5631.099024156157;5638.830835074954;5639.2668953035845;5662;13196.802047969288;20657.793422065886;21463.356099317047;21513.139474421005;21571.02930368137;2413.3604594782396;2575.896964121433;2625.3174174714522;2627.1461774923227;2804.7335503127374;10507.632232871812;10633.840492392621;10660.946695266473;10837.891621083845;12165.817512737316;2046.866953648023;2319.663648770919;2346.530693861235;2412.0713525292713;2513.572692642237;66832;71383.41381566154;76471.23528764697;77109.61445192795;89761.55119224427;16471.752923706154;16810.915945420194;16880.409185678687;17076.743848842278;17261.741073883903;29937.40125197484;29975.700242997726;30144;30515.2371190722;30538.847305763327;8678.6962456315;8755.387122901337;8911.37620366568;8917.687880924266;8949.865752013726;7244.203137654854;7265.782026539212;7306.415486761152;7460.253974602496;7467.365273951775;8435.662573497115;8445.619947102396;8501.404901656824;8507.914920850835;8566.528840913685;3083.5837161982845;3150.889718859829;3214.614246290413;3358.429067058606;3364.024432914476;833.5415521463292;914.3416739947228;929.8512238042016;961.3222678011984;988.5205675247499;17466;17670.823291767174;17865.553361165814;17952.19215135296;18122.818771812377;919.4942781470164;944.6693657220055;947.990520094804;950.6815216902277;989.9901000990042;9892.950535247277;9900.257480688977;9921.553530091163;10241.283110182216;10249.33379330341;369953;371101;373020;375144;417927;84143;85835;90237;93932.53033734788;95065;911.6763548940163;985.2856678907877;1012.832882574367;1020.2144348851343;1196.4675719304826;15699.607509812346;16334.591635209215;16388;16565.337386504405;16833.91583042077;38466.80766596149;39118.80440597779;39565.20869582535;40004.59995400125;40370.1925961485;54619;57100.143497848396;57323.14015289691;57495.712521437126;57549;8873.290136788912;8947.328950328882;8990.145936136056;9163.633454662006;9217.354785164975;10809.189610701116;12430;12474.625761227178;12758.808617870925;13032.804507932198;11352.262102963281;11546.249493782878;11571.6528504145;11709.707257318294;11985.700357491132;11264.774704506028;11319.377434241196;11379.886201138213;11458;11551.71120721955;11498;11650.242734222249;11689.941550292195;12158.392080396121;12443.128980971607;8852.734417967471;8906.643734250558;8981;8995.187574647533;9056.230220431336;10967.005240666611;11718.414079296172;11737;11862.466189021343;12051.81922271149 03:30:47 INFO - PROCESS | 10945 | |3;mootools.html;1228.1034844563462;1324.0533018891495;1328.2229895511125;1359.320339830085;1554.9144797036165;7511.849763004737;8319.875201871977;8491.617877195526;8493.532855692942;8505.659773609048;8170.673173073084;8184.386171037181;8255.091939886608;8259.463134896243;8273.586320683971;2086.6557018092;2333.53329334133;2373.288013595923;2396.8681722505257;2398.6641870138196;2392.0670938334065;2393.6888204533475;2400.7239167495786;2400.975990240093;2406.278116565032;2286.7370252420933;2321.292005938188;2326.2439707095177;2332.0088962191085;2378.2389635316704;2083.677030060343;2299.183789754638;2340.8361414700976;2345.0736958901307;2353.5528249632684;2327.4646831228742;2331.8484298520543;2358.811295096388;2361.1499860050367;2362.362162216192;8290.170982901722;8327.084020757711;8334;8349.624266907944;8357.414980951336;5155.046316431435;5251.947480525184;5267.631265811395;5269.7365131743645;5284.392294886099;3474.0793689672255;3496.615372309044;3521.3485505181625;3547.5210846535647;3611.3860643690637;1129.1080046763047;1144.9542018319257;1159.6636975277245;1170.1165619956962;1173.6420391780503;12353.938230308791;12374.319412432313;12386.071044671595;12398.00815934732;12424.813627795591;4679.99380133273;4703.835365762182;4751.360554259768;4786.64100192487;4848.781804818792;10451.425171615481;10469.267151299488;10475.685729427976;10496.632617858339;10503.52734126966;5364.463553644604;5371.704556249366;5374.5700343972385;5380.354357477049;5384.273123128328;4300.827966881289;4606.30905364198;4646.535346465326;4660.277656963176;4716.6698331116495;3935.1145992151537;3988.4017397390044;4014.3577027676015;4055.452513910643;4119.9176016479505;1313.7635225659474;1335.6460537957448;1338.0299283019926;1346.6498710335188;1347.3330701302723;788.3968763895624;882.642529775442;887.4497811357;921.6129225725211;923.6674797073048;5653.717314134359;5658.349289831722;5670.291213598301;5754.280714910637;5798.536117110621;936.8126374725082;943.6508491857919;949.4730424614405;961.6201600367956;983.9508024598741;3721.5534135903863;3766.246750649881;3773.603771603997;3785.1861849702445;3793.430985352219;10345.27583069193;10736.355818650749;10760.515776790064;10782.406967616856;11028.724281893017;10254.846177307347;10517;10979.670609881716;10988.340699558052;11000.669979900616;7858.960705196438;7890.763277101696;7927.167647397056;8000.199980001953;8012.318952888953;5544.473275038865;5741.799037033684;5781.82654520365;5791.611633064917;5813.970930145322;9700;9729.416235025921;9844.212463003087;9862.704118876445;9892.455914924749;9685.9031409685;9834.409935403899;9940.254480914105;9954.352967057119;9956.900430995598;6736.124303840469;7339.412846972336;7496.68807958616;7813.413993950363;7911;8181.6318265677;8205.097439281793;8218.753437396888;8223.136570660234;8271.090180080308;7266.636668166676;7543.73596924127;7573.766101072669;7624.733134340271;7797.376209903307;7155.499115061895;7464.440166987606;7520;7522.661480233293;7532.8493430132185;6926.203486599105;6942.375186233263;6960.408365289007;6995.720171193096;7001.824954376181;4834.20235661112;4864.683795553419;4889.144399729962;5033.723145227048;5073.061483625541;4870;4936.901261974668;4952.504749525018;4993.775280112331;5036.219385995177 03:30:47 INFO - PROCESS | 10945 | |4;prototype.html;331.1885879594993;339.1504281774157;339.6535533755568;345.9775114617549;346.326395161411;6234.812955611327;6305.274893387262;6320.3363646817115;6343.841403964903;6347.047942808581;6232.470240029603;6243.937560624392;6264.123022776815;6264.373562643734;6264.436200741932;4560.498345182027;4636.652251081166;4759.666823322369;4764.452088009872;4780.90438191236;4742.146413645542;4765.90468190636;4772.04559088182;4776.068666610013;4782.83260085897;4517.909641807162;4713.952860471386;4717.198076327016;4718.245080787075;4721.386219791422;4578.473475550321;4620.561046700558;4635.188841952661;4721.952780472186;4726.929096063562;4123.8556650517385;4137.048478849882;4139.027328577782;4146.253674338618;4147.066909945268;5992.460678538952;6025;6031.155638210654;6036.3360030396625;6045.183900173464;5506.559475241971;5508.20131080991;5519.337679478448;5522;5522.9447705523235;6430.196225471816;6551.574147680385;6566.113574667406;6570.211574611029;6570.540062195648;4615.26155815068;4619.838305659286;4624.09830083134;4628.074385122955;4630.328602352673;6816.897746533806;6842.589444633338;6842.931570684279;6851.760188393432;6854.520183587151;4712.69367491112;4712.740799256006;4723.149833030019;4723.315119307681;4729.527047295243;4773.498782627844;4779.856604301876;4780.020095880336;4782.856514304576;4787.4494433140635;5462.235287059815;5473.917891231635;5480.80817171405;5491.093969494988;5507.752151153208;6471.7734879279;6617.437517810944;6653.301403352675;6662.100616416722;6681.298463661343;1608.0191083439092;1625.8943168693997;1632.9183540823149;1636.0347395036986;1637.2223193982763;1019.9031092046243;1034.8240799064176;1041.3803786746873;1057.8730552333616;1059.3961441978154;6266.49868010558;6513.511486638521;6524.64114473699;6526.902096468557;6531.836704082436;6910.896336554955;6916.723331066701;6929.237783843773;6929.480288978246;6935.895961560581;6498.675066246668;6504.089427480157;6513.576617519846;6515.153030106056;6516.218053833571;3699.8335074921692;3723.795191264452;3737.0470530014672;3741.1769410729594;3744.2324323513612;6977.686004129826;7136;7163.31948464895;7183.748568800067;7224.096987876515;7075.2570980047385;7088.291170882871;7091.432685385157;7091.574505529685;7091.716331346792;7148.571085734872;7205.855882882418;7209.747658831916;7211.1707153678;7215.49491535598;6920.861582768417;6925.099737034153;6925.342092501204;6927.168739751262;6932.722691092502;6573.474122070127;6774.525783195129;6827.6244806536115;6844.5208835381045;6861.313868613099;7195.244499327495;7203.71185152588;7212.603306818175;7218.747343843151;7226.205117437183;4617.561331673485;4646.767661616973;4652.883677908079;4654.511276315938;4654.86035418938;6890.689918953759;6911.965440172969;6912.4815638826285;6913;6914.51598388108;6545.901811472737;6745.865082698417;6748.93251067483;6754.358335958076;6756.459483241427;6644.036614690746;6686.7993960181275;6689.030090636733;6693.364130407604;6699.564528305645;6581.605103693793;6583.30875258091;6593.538452308292;6597;6602.735890564516;6748.763793267212;6751.122354093936;6755;6758.4931130166415;6758.560693554903;6448.9032664511005;6595.340465953366;6601.075849381186;6602.207735071822;6605.768798092044 03:30:47 INFO - PROCESS | 10945 | |5;yui.html;731.7256028989127;748.1321666866436;757.3827330725459;762.8207371267755;781.6170076662434;14678.266086695663;15009.174495402749;15013.474528391494;15022.323995420205;15050.322735476902;12855.80716289254;12966.611001669942;12991.935040324784;13004.089713720043;13013.674658133528;542.5388419843131;586.3696526234294;595.1429940885133;598.9580729348947;599.0804115682429;605.8727667189895;605.9484943779784;609.3266940031268;609.7073404765715;610.2920612089977;556.3935310511541;628.946539544137;631.5326658272891;635.2789583822349;636.5321488705821;624.3631495874206;625.4964753373532;626.589583822597;626.7555653295218;627.3882964110002;459.68511569574946;460.19925329926025;461.21823509152;463.5017356341912;465.13252783558755;13496.93251533746;13526.864731352658;13527.729445411036;13531.797023044663;13575.321233938264;13102.344882755919;13852.93073534636;13884.542945121453;14395;14523.346449409803;11390.829137562943;11412.828807567894;12057.638270851889;12133.575324863676;12340.81488777669;3931.5282166140246;3989.8204580793645;4004.439378487014;4009.719319647626;4022.5776293489057;51550.484495154946;51996.48003519954;52557;54470.72764636151;57389.843558604676;10669;11092.279001864854;11183.552657893593;11359.375234362024;11750.529978800752;17372.913135434243;17481.388151414892;17748.645027099385;17758.644827103384;17770.289188432576;8229.300509456643;8384.832303353898;8401.95799021001;8522.78693032679;8561.357898157663;5108.693478391308;5114.130597798308;5126.128558145124;5143.717095559706;5222.086134926372;3323.069540528656;3379.2227787608986;3380.5098260752543;3382.1206486313736;3390.118569171984;585.912113183026;626.029654036242;656.4485831901226;658.3219284137347;664.4717449627558;716.8888822232562;726.4914559808155;742.8142964258935;746.2500187311825;746.6341492668553;9004.50475223856;9256.603530153088;9321.30090243221;9724.027597240362;10175;710.9822254443577;724.5362967700676;726.8037629840019;732.4323649171935;749.9850003000018;4245;4314.870553883388;4315.115401342718;4320.503142138631;4375.890602734893;63214.68392658099;63772;64561;64814.35185648177;65017;53080.469195308324;54190.45809541933;55122.17316740252;55609.72195138998;56188.157177642366;50087.49912500901;50861.23708144381;51028.489715102376;51474.22788658173;51903.740481298104;10204.662449258803;10398.376097434179;10407.791844162923;10420.583176673152;10448.738781530523;38540;38796.41805372865;39490.40764388594;39577.802110990415;39812.3050043679;43806.34290485709;44723.32915006342;45770.771146144056;48382.5161748378;48396.75801620969;11341;11355.37545435009;11509.53961841517;11616.593419230287;11849.822252666045;13575.728485430434;13851;13882;13947.814435773073;14269.714605708035;11561.364124972872;12743.044271679475;13318.600441986757;13645.795313070113;13958.511452099128;13441.327933603476;13688;13705.657358566115;13800.654983625089;13849.723005539632;13405.731885362433;13528.661783455493;13532.255725935169;13677.384517696528;13741.656458588215;11327.15046371542;11431.199816012799;11462.541498339973;11524.13568982313;11935.76128477443;10909.727256818644;11241.494132764208;11374.772504550028;11414.543418263176;11583.305001699924 03:30:47 INFO - PROCESS | 10945 | __end_tp_report 03:30:47 INFO - PROCESS | 10945 | __start_cc_report 03:30:47 INFO - PROCESS | 10945 | _x_x_mozilla_cycle_collect,843 03:30:47 INFO - PROCESS | 10945 | __end_cc_report 03:30:47 INFO - PROCESS | 10945 | __startTimestamp1464431447876__endTimestamp 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | ------- Summary: start ------- 03:30:47 INFO - PROCESS | 10945 | Number of tests: 6 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#0] dojo.html Cycles:165 Average:5568.17 Median:5803.22 stddev:621.89 (10.7%) stddev-sans-first:598.60 03:30:47 INFO - PROCESS | 10945 | Values: 3334.6 3406.5 3409.5 3433.2 3447.7 5635.6 5653.3 5654.0 5659.3 5663.4 5639.5 5666.9 5674.3 5674.7 5684.2 4866.4 5079.2 5189.1 5240.6 5277.7 5107.6 5140.8 5157.2 5158.9 5166.5 5058.4 5102.8 5128.4 5133.9 5144.1 5043.4 5051.6 5066.8 5067.6 5101.7 4920.4 4968.0 4972.7 4992.7 5027.1 5442.1 5472.6 5524.1 5527.1 5536.8 5887.1 5901.0 5903.3 5906.1 5907.2 5919.0 6017.8 6088.2 6124.8 6134.7 5556.3 5602.4 5605.4 5606.0 5642.8 6061.2 6104.7 6114.3 6115.2 6117.1 5919.7 5963.7 5981.2 5984.6 5994.1 5955.3 5963.3 5965.5 5967.5 5971.8 5878.3 5915.8 5921.1 5927.8 5936.1 5928.7 5960.7 5960.8 5964.3 5997.2 4512.3 4514.9 4523.4 4529.5 4556.3 4011.9 4034.9 4057.6 4081.6 4115.8 5696.9 5717.7 5720.3 5723.7 5725.4 5985.6 6014.1 6035.4 6038.5 6039.8 5514.6 5638.7 5646.2 5687.6 5690.2 5104.2 5128.5 5130.1 5141.0 5156.3 6170.3 6190.3 6192.7 6194.1 6196.4 5918.2 5998.2 6097.0 6099.9 6135.8 6182.9 6270.3 6276.2 6278.9 6279.5 5740.9 5910.6 5946.1 5949.3 5985.5 5955.6 5990.9 6019.4 6023.8 6057.3 5768.8 5811.0 5813.2 5813.5 5815.5 5745.2 5746.6 5801.6 5804.1 5858.0 5763.0 5816.4 5817.1 5828.2 5860.5 5889.9 5896.4 5900.3 5906.5 5931.6 5656.7 5803.2 5808.0 5819.1 5865.1 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#1] ext.html Cycles:180 Average:48421.75 Median:18152.04 stddev:93059.42 (512.7%) stddev-sans-first:93251.38 03:30:47 INFO - PROCESS | 10945 | Values: 660.9 670.9 676.4 733.2 747.8 35214.3 35760.6 35854.8 35936.1 35975.1 37872.2 38578.2 38602.0 38613.6 38722.6 8116.2 8799.7 8988.5 10170.2 10364.3 10246.7 10381.8 10384.6 10385.2 10388.3 10393.3 10505.8 10509.0 10527.3 10529.6 8426.3 10242.9 10316.7 10336.2 10381.7 10201.7 10298.9 10305.6 10321.0 10393.2 35000.0 35760.0 35813.8 35834.5 35836.6 3415.6 3431.8 3478.3 3604.7 3733.3 30665.7 30810.2 31071.4 31122.5 32096.4 4492.2 4580.2 4651.2 4678.9 4714.2 233422.0 237034.0 237460.0 238044.0 238561.0 35367.8 36366.6 54769.0 55731.4 55803.2 34265.8 34417.8 34428.5 34431.1 34447.0 13772.9 13792.4 14196.5 14393.9 14395.0 10335.8 10906.6 11040.2 11058.7 11071.5 9015.0 9077.9 9078.0 9143.2 9174.5 3330.1 3344.2 3351.4 3355.0 3401.4 998.9 1007.6 1035.0 1062.1 1117.7 29571.3 30043.0 30272.5 30574.4 30666.1 1128.4 1133.3 1135.3 1140.6 1149.0 15772.8 15778.3 15779.3 16111.9 16118.6 461204.0 465326.0 465676.0 466186.0 466656.0 52351.0 52503.5 52899.2 52960.7 53022.2 1210.3 1313.9 1321.5 1380.0 1387.9 28033.6 28377.0 28752.4 28831.7 29980.6 45451.3 45698.8 45737.3 46013.5 46166.5 310905.0 312048.0 312913.0 313975.0 314255.0 25627.5 26291.7 28485.4 28689.7 29055.9 39366.4 39416.4 39460.8 39744.8 39903.4 33354.0 33416.7 33436.8 34019.8 34159.8 32974.0 34037.5 35338.8 35838.8 35875.6 36525.5 36544.1 36857.3 40416.8 41120.8 29117.6 31650.2 32588.7 32634.7 32821.7 25598.5 25752.0 26008.7 26205.7 26336.5 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#2] jquery.html Cycles:180 Average:26156.75 Median:19752.31 stddev:63459.34 (321.3%) stddev-sans-first:63607.86 03:30:47 INFO - PROCESS | 10945 | Values: 385.8 398.5 399.6 402.4 404.8 14328.7 15070.0 17358.7 17863.2 17876.3 16074.6 16341.6 16361.1 16366.6 16728.2 5715.5 5820.6 5849.5 5875.5 5876.5 4304.4 5843.2 5887.2 6213.3 6457.6 6306.9 6321.8 6350.6 6403.9 6418.7 6145.0 6269.2 6288.8 6325.1 6348.5 5626.9 5631.1 5638.8 5639.3 5662.0 13196.8 20657.8 21463.4 21513.1 21571.0 2413.4 2575.9 2625.3 2627.1 2804.7 10507.6 10633.8 10660.9 10837.9 12165.8 2046.9 2319.7 2346.5 2412.1 2513.6 66832.0 71383.4 76471.2 77109.6 89761.6 16471.8 16810.9 16880.4 17076.7 17261.7 29937.4 29975.7 30144.0 30515.2 30538.8 8678.7 8755.4 8911.4 8917.7 8949.9 7244.2 7265.8 7306.4 7460.3 7467.4 8435.7 8445.6 8501.4 8507.9 8566.5 3083.6 3150.9 3214.6 3358.4 3364.0 833.5 914.3 929.9 961.3 988.5 17466.0 17670.8 17865.6 17952.2 18122.8 919.5 944.7 948.0 950.7 990.0 9893.0 9900.3 9921.6 10241.3 10249.3 369953.0 371101.0 373020.0 375144.0 417927.0 84143.0 85835.0 90237.0 93932.5 95065.0 911.7 985.3 1012.8 1020.2 1196.5 15699.6 16334.6 16388.0 16565.3 16833.9 38466.8 39118.8 39565.2 40004.6 40370.2 54619.0 57100.1 57323.1 57495.7 57549.0 8873.3 8947.3 8990.1 9163.6 9217.4 10809.2 12430.0 12474.6 12758.8 13032.8 11352.3 11546.2 11571.7 11709.7 11985.7 11264.8 11319.4 11379.9 11458.0 11551.7 11498.0 11650.2 11689.9 12158.4 12443.1 8852.7 8906.6 8981.0 8995.2 9056.2 10967.0 11718.4 11737.0 11862.5 12051.8 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#3] mootools.html Cycles:180 Average:5678.29 Median:4973.14 stddev:3220.96 (64.8%) stddev-sans-first:3212.63 03:30:47 INFO - PROCESS | 10945 | Values: 1228.1 1324.1 1328.2 1359.3 1554.9 7511.8 8319.9 8491.6 8493.5 8505.7 8170.7 8184.4 8255.1 8259.5 8273.6 2086.7 2333.5 2373.3 2396.9 2398.7 2392.1 2393.7 2400.7 2401.0 2406.3 2286.7 2321.3 2326.2 2332.0 2378.2 2083.7 2299.2 2340.8 2345.1 2353.6 2327.5 2331.8 2358.8 2361.1 2362.4 8290.2 8327.1 8334.0 8349.6 8357.4 5155.0 5251.9 5267.6 5269.7 5284.4 3474.1 3496.6 3521.3 3547.5 3611.4 1129.1 1145.0 1159.7 1170.1 1173.6 12353.9 12374.3 12386.1 12398.0 12424.8 4680.0 4703.8 4751.4 4786.6 4848.8 10451.4 10469.3 10475.7 10496.6 10503.5 5364.5 5371.7 5374.6 5380.4 5384.3 4300.8 4606.3 4646.5 4660.3 4716.7 3935.1 3988.4 4014.4 4055.5 4119.9 1313.8 1335.6 1338.0 1346.6 1347.3 788.4 882.6 887.4 921.6 923.7 5653.7 5658.3 5670.3 5754.3 5798.5 936.8 943.7 949.5 961.6 984.0 3721.6 3766.2 3773.6 3785.2 3793.4 10345.3 10736.4 10760.5 10782.4 11028.7 10254.8 10517.0 10979.7 10988.3 11000.7 7859.0 7890.8 7927.2 8000.2 8012.3 5544.5 5741.8 5781.8 5791.6 5814.0 9700.0 9729.4 9844.2 9862.7 9892.5 9685.9 9834.4 9940.3 9954.4 9956.9 6736.1 7339.4 7496.7 7813.4 7911.0 8181.6 8205.1 8218.8 8223.1 8271.1 7266.6 7543.7 7573.8 7624.7 7797.4 7155.5 7464.4 7520.0 7522.7 7532.8 6926.2 6942.4 6960.4 6995.7 7001.8 4834.2 4864.7 4889.1 5033.7 5073.1 4870.0 4936.9 4952.5 4993.8 5036.2 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#4] prototype.html Cycles:180 Average:5569.41 Median:6388.62 stddev:1709.41 (26.8%) stddev-sans-first:1668.37 03:30:47 INFO - PROCESS | 10945 | Values: 331.2 339.2 339.7 346.0 346.3 6234.8 6305.3 6320.3 6343.8 6347.0 6232.5 6243.9 6264.1 6264.4 6264.4 4560.5 4636.7 4759.7 4764.5 4780.9 4742.1 4765.9 4772.0 4776.1 4782.8 4517.9 4714.0 4717.2 4718.2 4721.4 4578.5 4620.6 4635.2 4722.0 4726.9 4123.9 4137.0 4139.0 4146.3 4147.1 5992.5 6025.0 6031.2 6036.3 6045.2 5506.6 5508.2 5519.3 5522.0 5522.9 6430.2 6551.6 6566.1 6570.2 6570.5 4615.3 4619.8 4624.1 4628.1 4630.3 6816.9 6842.6 6842.9 6851.8 6854.5 4712.7 4712.7 4723.1 4723.3 4729.5 4773.5 4779.9 4780.0 4782.9 4787.4 5462.2 5473.9 5480.8 5491.1 5507.8 6471.8 6617.4 6653.3 6662.1 6681.3 1608.0 1625.9 1632.9 1636.0 1637.2 1019.9 1034.8 1041.4 1057.9 1059.4 6266.5 6513.5 6524.6 6526.9 6531.8 6910.9 6916.7 6929.2 6929.5 6935.9 6498.7 6504.1 6513.6 6515.2 6516.2 3699.8 3723.8 3737.0 3741.2 3744.2 6977.7 7136.0 7163.3 7183.7 7224.1 7075.3 7088.3 7091.4 7091.6 7091.7 7148.6 7205.9 7209.7 7211.2 7215.5 6920.9 6925.1 6925.3 6927.2 6932.7 6573.5 6774.5 6827.6 6844.5 6861.3 7195.2 7203.7 7212.6 7218.7 7226.2 4617.6 4646.8 4652.9 4654.5 4654.9 6890.7 6912.0 6912.5 6913.0 6914.5 6545.9 6745.9 6748.9 6754.4 6756.5 6644.0 6686.8 6689.0 6693.4 6699.6 6581.6 6583.3 6593.5 6597.0 6602.7 6748.8 6751.1 6755.0 6758.5 6758.6 6448.9 6595.3 6601.1 6602.2 6605.8 03:30:47 INFO - PROCESS | 10945 | 03:30:47 INFO - PROCESS | 10945 | [#5] yui.html Cycles:180 Average:15133.79 Median:4133.79 stddev:17435.42 (421.8%) stddev-sans-first:17450.78 03:30:47 INFO - PROCESS | 10945 | Values: 731.7 748.1 757.4 762.8 781.6 14678.3 15009.2 15013.5 15022.3 15050.3 12855.8 12966.6 12991.9 13004.1 13013.7 542.5 586.4 595.1 599.0 599.1 605.9 605.9 609.3 609.7 610.3 556.4 628.9 631.5 635.3 636.5 624.4 625.5 626.6 626.8 627.4 459.7 460.2 461.2 463.5 465.1 13496.9 13526.9 13527.7 13531.8 13575.3 13102.3 13852.9 13884.5 14395.0 14523.3 11390.8 11412.8 12057.6 12133.6 12340.8 3931.5 3989.8 4004.4 4009.7 4022.6 51550.5 51996.5 52557.0 54470.7 57389.8 10669.0 11092.3 11183.6 11359.4 11750.5 17372.9 17481.4 17748.6 17758.6 17770.3 8229.3 8384.8 8402.0 8522.8 8561.4 5108.7 5114.1 5126.1 5143.7 5222.1 3323.1 3379.2 3380.5 3382.1 3390.1 585.9 626.0 656.4 658.3 664.5 716.9 726.5 742.8 746.3 746.6 9004.5 9256.6 9321.3 9724.0 10175.0 711.0 724.5 726.8 732.4 750.0 4245.0 4314.9 4315.1 4320.5 4375.9 63214.7 63772.0 64561.0 64814.4 65017.0 53080.5 54190.5 55122.2 55609.7 56188.2 50087.5 50861.2 51028.5 51474.2 51903.7 10204.7 10398.4 10407.8 10420.6 10448.7 38540.0 38796.4 39490.4 39577.8 39812.3 43806.3 44723.3 45770.8 48382.5 48396.8 11341.0 11355.4 11509.5 11616.6 11849.8 13575.7 13851.0 13882.0 13947.8 14269.7 11561.4 12743.0 13318.6 13645.8 13958.5 13441.3 13688.0 13705.7 13800.7 13849.7 13405.7 13528.7 13532.3 13677.4 13741.7 11327.2 11431.2 11462.5 11524.1 11935.8 10909.7 11241.5 11374.8 11414.5 11583.3 03:30:47 INFO - PROCESS | 10945 | -------- Summary: end -------- 03:30:47 INFO - PROCESS | 10945 | 03:30:48 INFO - TEST-INFO | 10945: exit 0 03:30:48 INFO - TEST-OK | dromaeo_css | took 1112545ms 03:30:48 INFO - TEST-START | kraken 03:30:48 INFO - operating with platform_type : linux_ 03:30:48 INFO - Initialising browser for kraken test... 03:30:48 INFO - TEST-INFO | started process 11136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9giGOP/profile http://localhost:49023/getInfo.html) 03:30:53 INFO - PROCESS | 11136 | __metrics Screen width/height:1600/1200 03:30:53 INFO - PROCESS | 11136 | colorDepth:24 03:30:53 INFO - PROCESS | 11136 | Browser inner width/height: 1024/697 03:30:53 INFO - PROCESS | 11136 | __metrics 03:30:54 ERROR - PROCESS | 11136 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:30:55 INFO - TEST-INFO | 11136: exit 0 03:30:55 INFO - Browser initialized. 03:30:55 INFO - Running cycle 1/1 for kraken test... 03:30:55 INFO - TEST-INFO | started process 11233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9giGOP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:06 INFO - PROCESS | 11233 | RSS: Main: 141930496 03:31:06 INFO - PROCESS | 11233 | 03:31:09 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49023/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:10 INFO - PROCESS | 11233 | RSS: Main: 197046272 03:31:10 INFO - PROCESS | 11233 | 03:31:12 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49023/tests/kraken/driver.html?testName=audio-dft) 03:31:13 INFO - PROCESS | 11233 | RSS: Main: 181284864 03:31:13 INFO - PROCESS | 11233 | 03:31:16 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49023/tests/kraken/driver.html?testName=audio-fft) 03:31:16 INFO - PROCESS | 11233 | RSS: Main: 272068608 03:31:16 INFO - PROCESS | 11233 | 03:31:18 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49023/tests/kraken/driver.html?testName=audio-oscillator) 03:31:19 INFO - PROCESS | 11233 | RSS: Main: 178528256 03:31:19 INFO - PROCESS | 11233 | 03:31:21 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:22 INFO - PROCESS | 11233 | RSS: Main: 175996928 03:31:22 INFO - PROCESS | 11233 | 03:31:25 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49023/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:25 INFO - PROCESS | 11233 | RSS: Main: 210788352 03:31:25 INFO - PROCESS | 11233 | 03:31:29 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49023/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:29 INFO - PROCESS | 11233 | RSS: Main: 211603456 03:31:29 INFO - PROCESS | 11233 | 03:31:32 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49023/tests/kraken/driver.html?testName=json-parse-financial) 03:31:33 INFO - PROCESS | 11233 | RSS: Main: 210784256 03:31:33 INFO - PROCESS | 11233 | 03:31:34 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:35 INFO - PROCESS | 11233 | RSS: Main: 190316544 03:31:35 INFO - PROCESS | 11233 | 03:31:36 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:37 INFO - PROCESS | 11233 | RSS: Main: 195723264 03:31:37 INFO - PROCESS | 11233 | 03:31:39 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:40 INFO - PROCESS | 11233 | RSS: Main: 207982592 03:31:40 INFO - PROCESS | 11233 | 03:31:42 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:43 INFO - PROCESS | 11233 | RSS: Main: 211189760 03:31:43 INFO - PROCESS | 11233 | 03:31:45 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:46 INFO - PROCESS | 11233 | RSS: Main: 206827520 03:31:46 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | Cycle 1(1): loaded http://localhost:49023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49023/tests/kraken/driver.html?testName=ai-astar) 03:31:48 INFO - PROCESS | 11233 | RSS: Main: 271282176 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | __start_tp_report 03:31:48 INFO - PROCESS | 11233 | _x_x_mozilla_page_load 03:31:48 INFO - PROCESS | 11233 | _x_x_mozilla_page_load_details 03:31:48 INFO - PROCESS | 11233 | |i|pagename|runs| 03:31:48 INFO - PROCESS | 11233 | |0;ai-astar;111;111;110;110;112;109;105;109;111;110 03:31:48 INFO - PROCESS | 11233 | |1;audio-beat-detection;153;136;152;188;129;159;158;134;206;138 03:31:48 INFO - PROCESS | 11233 | |2;audio-dft;162;161;161;160;161;161;162;163;162;162 03:31:48 INFO - PROCESS | 11233 | |3;audio-fft;77;75;77;164;77;77;77;76;160;76 03:31:48 INFO - PROCESS | 11233 | |4;audio-oscillator;92;94;155;93;91;93;154;92;93;147 03:31:48 INFO - PROCESS | 11233 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;117;117;118 03:31:48 INFO - PROCESS | 11233 | |6;imaging-darkroom;145;146;145;145;146;145;146;145;145;145 03:31:48 INFO - PROCESS | 11233 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;94;94 03:31:48 INFO - PROCESS | 11233 | |8;json-parse-financial;54;53;53;53;56;54;55;72;54;52 03:31:48 INFO - PROCESS | 11233 | |9;json-stringify-tinderbox;59;59;59;58;60;59;59;58;59;58 03:31:48 INFO - PROCESS | 11233 | |10;stanford-crypto-aes;72;74;73;73;75;73;74;74;74;72 03:31:48 INFO - PROCESS | 11233 | |11;stanford-crypto-ccm;117;114;110;113;114;112;112;121;127;123 03:31:48 INFO - PROCESS | 11233 | |12;stanford-crypto-pbkdf2;162;167;158;158;159;161;156;166;164;160 03:31:48 INFO - PROCESS | 11233 | |13;stanford-crypto-sha256-iterative;68;69;66;67;76;67;66;66;66;66 03:31:48 INFO - PROCESS | 11233 | __end_tp_report 03:31:48 INFO - PROCESS | 11233 | __start_cc_report 03:31:48 INFO - PROCESS | 11233 | _x_x_mozilla_cycle_collect,1593 03:31:48 INFO - PROCESS | 11233 | __end_cc_report 03:31:48 INFO - PROCESS | 11233 | __startTimestamp1464431508284__endTimestamp 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | ------- Summary: start ------- 03:31:48 INFO - PROCESS | 11233 | Number of tests: 14 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.93 (1.7%) stddev-sans-first:2.00 03:31:48 INFO - PROCESS | 11233 | Values: 111.0 111.0 110.0 110.0 112.0 109.0 105.0 109.0 111.0 110.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:155.50 stddev:24.71 (15.9%) stddev-sans-first:26.19 03:31:48 INFO - PROCESS | 11233 | Values: 153.0 136.0 152.0 188.0 129.0 159.0 158.0 134.0 206.0 138.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 03:31:48 INFO - PROCESS | 11233 | Values: 162.0 161.0 161.0 160.0 161.0 161.0 162.0 163.0 162.0 162.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#3] audio-fft Cycles:10 Average:93.60 Median:77.00 stddev:36.07 (46.8%) stddev-sans-first:37.75 03:31:48 INFO - PROCESS | 11233 | Values: 77.0 75.0 77.0 164.0 77.0 77.0 77.0 76.0 160.0 76.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.50 stddev:28.79 (31.1%) stddev-sans-first:29.76 03:31:48 INFO - PROCESS | 11233 | Values: 92.0 94.0 155.0 93.0 91.0 93.0 154.0 92.0 93.0 147.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:31:48 INFO - PROCESS | 11233 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:31:48 INFO - PROCESS | 11233 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:31:48 INFO - PROCESS | 11233 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.00 stddev:5.87 (10.9%) stddev-sans-first:6.20 03:31:48 INFO - PROCESS | 11233 | Values: 54.0 53.0 53.0 53.0 56.0 54.0 55.0 72.0 54.0 52.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:31:48 INFO - PROCESS | 11233 | Values: 59.0 59.0 59.0 58.0 60.0 59.0 59.0 58.0 59.0 58.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:0.88 03:31:48 INFO - PROCESS | 11233 | Values: 72.0 74.0 73.0 73.0 75.0 73.0 74.0 74.0 74.0 72.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:5.58 (4.8%) stddev-sans-first:5.91 03:31:48 INFO - PROCESS | 11233 | Values: 117.0 114.0 110.0 113.0 114.0 112.0 112.0 121.0 127.0 123.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:3.63 (2.3%) stddev-sans-first:3.84 03:31:48 INFO - PROCESS | 11233 | Values: 162.0 167.0 158.0 158.0 159.0 161.0 156.0 166.0 164.0 160.0 03:31:48 INFO - PROCESS | 11233 | 03:31:48 INFO - PROCESS | 11233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:3.09 (4.6%) stddev-sans-first:3.28 03:31:48 INFO - PROCESS | 11233 | Values: 68.0 69.0 66.0 67.0 76.0 67.0 66.0 66.0 66.0 66.0 03:31:48 INFO - PROCESS | 11233 | -------- Summary: end -------- 03:31:48 INFO - PROCESS | 11233 | 03:31:49 INFO - TEST-INFO | 11233: exit 0 03:31:49 INFO - TEST-OK | kraken | took 60608ms 03:31:49 INFO - SUITE-END | took 1173s 03:31:49 INFO - Completed test suite (00:19:33) 03:31:49 INFO - javascript benchmark 03:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.566506354174, 3406.4719968404906, 3409.471531912553, 3433.1931995980954, 3447.6897079262862, 5635.633683810554, 5653.349864765553, 5654.0, 5659.292588426447, 5663.377028526858, 5639.492445679888, 5666.9433305666935, 5674.347450043247, 5674.716264186794, 5684.204211410406, 4866.391701037371, 5079.212722028092, 5189.065968125736, 5240.60695447841, 5277.656952298107, 5107.591392688576, 5140.768665410047, 5157.226416037605, 5158.871028224287, 5166.509181627739, 5058.367704036996, 5102.770375333119, 5128.410232823236, 5133.922991155136, 5144.09978253806, 5043.394792624872, 5051.646384753069, 5066.82266120684, 5067.619928505377, 5101.7194054327, 4920.360353154067, 4967.950320496821, 4972.651914365996, 4992.725400102993, 5027.09512287788, 5442.12925931853, 5472.634329887131, 5524.06090964537, 5527.060399732055, 5536.806211782568, 5887.0580707086665, 5900.97049514754, 5903.321118071433, 5906.084556893688, 5907.172995780594, 5918.970405147947, 6017.7592896284095, 6088.208532890741, 6124.816255512342, 6134.6625935573975, 5556.277683901108, 5602.38373778884, 5605.355384130796, 5606.0, 5642.830715078554, 6061.181740465069, 6104.664243466652, 6114.28542962895, 6115.205023346936, 6117.143599896018, 5919.704014799243, 5963.701814909237, 5981.162637230791, 5984.640921544721, 5994.130851026664, 5955.315138759098, 5963.2844058713235, 5965.492933100735, 5967.522598192134, 5971.761129554856, 5878.29460464747, 5915.822525324247, 5921.111833225051, 5927.8221653350465, 5936.1095835625, 5928.67392293428, 5960.731767070492, 5960.761569537257, 5964.254468191476, 5997.220361352996, 4512.323151527297, 4514.864554063383, 4523.36672865799, 4529.479109902338, 4556.270996640588, 4011.8796436106963, 4034.8587799426878, 4057.6145266199665, 4081.551029386765, 4115.835366585363, 5696.857578560486, 5717.742701578439, 5720.342160651495, 5723.742431590588, 5725.427457254241, 5985.6408615483215, 6014.127951447103, 6035.366286539938, 6038.547108966845, 6039.849003774941, 5514.5864060195645, 5638.689872056994, 5646.153077038477, 5687.601867869293, 5690.174924635905, 5104.2343648453025, 5128.461511541309, 5130.050940576006, 5141.048905952411, 5156.303898973665, 6170.321264660884, 6190.288116866618, 6192.659403732838, 6194.101855230966, 6196.411340922696, 5918.201042859159, 5998.160257563857, 6097.0, 6099.9390006099375, 6135.785247516315, 6182.9269507856525, 6270.278917924497, 6276.152719382825, 6278.937210628018, 6279.497640188865, 5740.856478588069, 5910.615809972338, 5946.07835785454, 5949.3455719871645, 5985.461308482258, 5955.553333500092, 5990.910136348046, 6019.428154325507, 6023.789167379296, 6057.333693293822, 5768.769249229984, 5811.0, 5813.244278243801, 5813.476787089182, 5815.505682017076, 5745.166950792195, 5746.597738158289, 5801.564882633735, 5804.100364443518, 5857.970710146422, 5763.0, 5816.447437493432, 5817.127430885401, 5828.154917536848, 5860.531157507304, 5889.882202356014, 5896.439838215363, 5900.291964964232, 5906.468417842415, 5931.584789064724, 5656.717164141694, 5803.216565763568, 5808.0, 5819.127130930395, 5865.061590145556], "value": 5527.693826998264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.9259952577062, 670.9127813384259, 676.4250387170903, 733.1751779248344, 747.8167848877026, 35214.29571408573, 35760.64239357609, 35854.820725896396, 35936.101597460074, 35975.10062248442, 37872.24255514888, 38578.22843543127, 38602.0, 38613.613863861356, 38722.61277387232, 8116.188381161866, 8799.692010779609, 8988.460692358447, 10170.237232207577, 10364.27450078491, 10246.7438314042, 10381.792364152712, 10384.63653772118, 10385.169186465102, 10388.272820902539, 10393.32443391181, 10505.789884202311, 10509.0, 10527.315724477923, 10529.578816847317, 8426.325893928471, 10242.897571024268, 10316.690499284958, 10336.224783141295, 10381.688549343531, 10201.744956376077, 10298.9485052575, 10305.587776488932, 10321.0, 10393.16854651626, 35000.0, 35760.0, 35813.82093089544, 35834.46248306277, 35836.64163358359, 3415.55597772288, 3431.8284085795613, 3478.2521757821937, 3604.6936010439144, 3733.253349330145, 30665.69334306651, 30810.22974425635, 31071.37857242865, 31122.533162002586, 32096.35807283841, 4492.168948744493, 4580.221362368406, 4651.209294419957, 4678.906421871544, 4714.1985862403135, 233422.0, 237034.0, 237460.0, 238043.99999999825, 238561.0, 35367.823160884545, 36366.63633363633, 54769.0, 55731.442685573435, 55803.162952555744, 34265.828670856485, 34417.82791086079, 34428.48357274643, 34431.073358764785, 34447.0, 13772.862271377358, 13792.379342929593, 14196.503122390666, 14393.856061439252, 14395.0, 10335.844962325571, 10906.563737450413, 11040.171987101, 11058.723531911766, 11071.501782419811, 9014.954925225333, 9077.909220907706, 9078.0, 9143.222826059859, 9174.541272936327, 3330.084226837639, 3344.2141096842224, 3351.4135026370286, 3355.043812513422, 3401.387750204987, 998.9450580218157, 1007.6221416968637, 1034.9689509314733, 1062.129054175584, 1117.7373317270435, 29571.26071848178, 30043.0, 30272.54591181134, 30574.38851222963, 30666.080017599506, 1128.430142777892, 1133.3086817041599, 1135.2677522997785, 1140.5722853929776, 1148.9655310340704, 15772.76340854888, 15778.289976951064, 15779.28993195309, 16111.919440402722, 16118.597035074217, 461204.0, 465326.0, 465676.0, 466186.0, 466656.0, 52351.0, 52503.47496525062, 52899.206511902354, 52960.735196324546, 53022.204666930025, 1210.3403645013489, 1313.8817506424468, 1321.491225878044, 1380.0339762166323, 1387.9444822207201, 28033.57949630798, 28377.0, 28752.42495150127, 28831.711682882902, 29980.550291745207, 45451.31823022591, 45698.77150614226, 45737.31394029159, 46013.539864602266, 46166.53833461623, 310905.0, 312048.0, 312913.0, 313975.0, 314255.0, 25627.54028206243, 26291.737082629694, 28485.43029139447, 28689.713102868704, 29055.85472072626, 39366.409503858034, 39416.40875386814, 39460.802695986335, 39744.801275993435, 39903.40144897887, 33354.0, 33416.66583334136, 33436.83281583576, 34019.82990085034, 34159.829200853834, 32974.0, 34037.48943765895, 35338.82330588331, 35838.820805895804, 35875.64124358723, 36525.45211821772, 36544.08639784026, 36857.26285474329, 40416.79791601023, 41120.79439602783, 29117.563236551894, 31650.208744781565, 32588.674113259513, 32634.673653263162, 32821.67178328186, 25598.488030239663, 25752.0, 26008.73991260063, 26205.73794262033, 26336.473270534865], "value": 17792.02486649581, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.81095263320975, 398.5496389080339, 399.57445320733416, 402.4164960806829, 404.7814180342615, 14328.713425731505, 15070.020448670855, 17358.652826943453, 17863.19615617297, 17876.284948602057, 16074.59813504663, 16341.5914602135, 16361.100139492353, 16366.590835229124, 16728.16359182039, 5715.5427565794635, 5820.621659592113, 5849.502792262663, 5875.529957603381, 5876.529877609781, 4304.354346847982, 5843.2403787507565, 5887.205227294303, 6213.316535181127, 6457.580257283285, 6306.873862522747, 6321.841953951165, 6350.555461117724, 6403.935960640404, 6418.711157997878, 6144.969275153596, 6269.216347956505, 6288.779892703757, 6325.146105275775, 6348.460380867632, 5626.915596266059, 5631.099024156157, 5638.830835074954, 5639.2668953035845, 5662.0, 13196.802047969288, 20657.793422065886, 21463.356099317047, 21513.139474421005, 21571.02930368137, 2413.3604594782396, 2575.896964121433, 2625.3174174714522, 2627.1461774923227, 2804.7335503127374, 10507.632232871812, 10633.840492392621, 10660.946695266473, 10837.891621083845, 12165.817512737316, 2046.866953648023, 2319.663648770919, 2346.530693861235, 2412.0713525292713, 2513.572692642237, 66832.0, 71383.41381566154, 76471.23528764697, 77109.61445192795, 89761.55119224427, 16471.752923706154, 16810.915945420194, 16880.409185678687, 17076.743848842278, 17261.741073883903, 29937.40125197484, 29975.700242997726, 30144.0, 30515.2371190722, 30538.847305763327, 8678.6962456315, 8755.387122901337, 8911.37620366568, 8917.687880924266, 8949.865752013726, 7244.203137654854, 7265.782026539212, 7306.415486761152, 7460.253974602496, 7467.365273951775, 8435.662573497115, 8445.619947102396, 8501.404901656824, 8507.914920850835, 8566.528840913685, 3083.5837161982845, 3150.889718859829, 3214.614246290413, 3358.429067058606, 3364.024432914476, 833.5415521463292, 914.3416739947228, 929.8512238042016, 961.3222678011984, 988.5205675247499, 17466.0, 17670.823291767174, 17865.553361165814, 17952.19215135296, 18122.818771812377, 919.4942781470164, 944.6693657220055, 947.990520094804, 950.6815216902277, 989.9901000990042, 9892.950535247277, 9900.257480688977, 9921.553530091163, 10241.283110182216, 10249.33379330341, 369953.0, 371101.0, 373020.0, 375144.0, 417927.0, 84143.0, 85835.0, 90237.0, 93932.53033734788, 95065.0, 911.6763548940163, 985.2856678907877, 1012.832882574367, 1020.2144348851343, 1196.4675719304826, 15699.607509812346, 16334.591635209215, 16388.0, 16565.337386504405, 16833.91583042077, 38466.80766596149, 39118.80440597779, 39565.20869582535, 40004.59995400125, 40370.1925961485, 54619.0, 57100.143497848396, 57323.14015289691, 57495.712521437126, 57549.0, 8873.290136788912, 8947.328950328882, 8990.145936136056, 9163.633454662006, 9217.354785164975, 10809.189610701116, 12430.0, 12474.625761227178, 12758.808617870925, 13032.804507932198, 11352.262102963281, 11546.249493782878, 11571.6528504145, 11709.707257318294, 11985.700357491132, 11264.774704506028, 11319.377434241196, 11379.886201138213, 11458.0, 11551.71120721955, 11498.0, 11650.242734222249, 11689.941550292195, 12158.392080396121, 12443.128980971607, 8852.734417967471, 8906.643734250558, 8981.0, 8995.187574647533, 9056.230220431336, 10967.005240666611, 11718.414079296172, 11737.0, 11862.466189021343, 12051.81922271149], "value": 9648.891128686922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.1034844563462, 1324.0533018891495, 1328.2229895511125, 1359.320339830085, 1554.9144797036165, 7511.849763004737, 8319.875201871977, 8491.617877195526, 8493.532855692942, 8505.659773609048, 8170.673173073084, 8184.386171037181, 8255.091939886608, 8259.463134896243, 8273.586320683971, 2086.6557018092, 2333.53329334133, 2373.288013595923, 2396.8681722505257, 2398.6641870138196, 2392.0670938334065, 2393.6888204533475, 2400.7239167495786, 2400.975990240093, 2406.278116565032, 2286.7370252420933, 2321.292005938188, 2326.2439707095177, 2332.0088962191085, 2378.2389635316704, 2083.677030060343, 2299.183789754638, 2340.8361414700976, 2345.0736958901307, 2353.5528249632684, 2327.4646831228742, 2331.8484298520543, 2358.811295096388, 2361.1499860050367, 2362.362162216192, 8290.170982901722, 8327.084020757711, 8334.0, 8349.624266907944, 8357.414980951336, 5155.046316431435, 5251.947480525184, 5267.631265811395, 5269.7365131743645, 5284.392294886099, 3474.0793689672255, 3496.615372309044, 3521.3485505181625, 3547.5210846535647, 3611.3860643690637, 1129.1080046763047, 1144.9542018319257, 1159.6636975277245, 1170.1165619956962, 1173.6420391780503, 12353.938230308791, 12374.319412432313, 12386.071044671595, 12398.00815934732, 12424.813627795591, 4679.99380133273, 4703.835365762182, 4751.360554259768, 4786.64100192487, 4848.781804818792, 10451.425171615481, 10469.267151299488, 10475.685729427976, 10496.632617858339, 10503.52734126966, 5364.463553644604, 5371.704556249366, 5374.5700343972385, 5380.354357477049, 5384.273123128328, 4300.827966881289, 4606.30905364198, 4646.535346465326, 4660.277656963176, 4716.6698331116495, 3935.1145992151537, 3988.4017397390044, 4014.3577027676015, 4055.452513910643, 4119.9176016479505, 1313.7635225659474, 1335.6460537957448, 1338.0299283019926, 1346.6498710335188, 1347.3330701302723, 788.3968763895624, 882.642529775442, 887.4497811357, 921.6129225725211, 923.6674797073048, 5653.717314134359, 5658.349289831722, 5670.291213598301, 5754.280714910637, 5798.536117110621, 936.8126374725082, 943.6508491857919, 949.4730424614405, 961.6201600367956, 983.9508024598741, 3721.5534135903863, 3766.246750649881, 3773.603771603997, 3785.1861849702445, 3793.430985352219, 10345.27583069193, 10736.355818650749, 10760.515776790064, 10782.406967616856, 11028.724281893017, 10254.846177307347, 10517.0, 10979.670609881716, 10988.340699558052, 11000.669979900616, 7858.960705196438, 7890.763277101696, 7927.167647397056, 8000.199980001953, 8012.318952888953, 5544.473275038865, 5741.799037033684, 5781.82654520365, 5791.611633064917, 5813.970930145322, 9700.0, 9729.416235025921, 9844.212463003087, 9862.704118876445, 9892.455914924749, 9685.9031409685, 9834.409935403899, 9940.254480914105, 9954.352967057119, 9956.900430995598, 6736.124303840469, 7339.412846972336, 7496.68807958616, 7813.413993950363, 7911.0, 8181.6318265677, 8205.097439281793, 8218.753437396888, 8223.136570660234, 8271.090180080308, 7266.636668166676, 7543.73596924127, 7573.766101072669, 7624.733134340271, 7797.376209903307, 7155.499115061895, 7464.440166987606, 7520.0, 7522.661480233293, 7532.8493430132185, 6926.203486599105, 6942.375186233263, 6960.408365289007, 6995.720171193096, 7001.824954376181, 4834.20235661112, 4864.683795553419, 4889.144399729962, 5033.723145227048, 5073.061483625541, 4870.0, 4936.901261974668, 4952.504749525018, 4993.775280112331, 5036.219385995177], "value": 4555.007741742481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.1885879594993, 339.1504281774157, 339.6535533755568, 345.9775114617549, 346.326395161411, 6234.812955611327, 6305.274893387262, 6320.3363646817115, 6343.841403964903, 6347.047942808581, 6232.470240029603, 6243.937560624392, 6264.123022776815, 6264.373562643734, 6264.436200741932, 4560.498345182027, 4636.652251081166, 4759.666823322369, 4764.452088009872, 4780.90438191236, 4742.146413645542, 4765.90468190636, 4772.04559088182, 4776.068666610013, 4782.83260085897, 4517.909641807162, 4713.952860471386, 4717.198076327016, 4718.245080787075, 4721.386219791422, 4578.473475550321, 4620.561046700558, 4635.188841952661, 4721.952780472186, 4726.929096063562, 4123.8556650517385, 4137.048478849882, 4139.027328577782, 4146.253674338618, 4147.066909945268, 5992.460678538952, 6025.0, 6031.155638210654, 6036.3360030396625, 6045.183900173464, 5506.559475241971, 5508.20131080991, 5519.337679478448, 5522.0, 5522.9447705523235, 6430.196225471816, 6551.574147680385, 6566.113574667406, 6570.211574611029, 6570.540062195648, 4615.26155815068, 4619.838305659286, 4624.09830083134, 4628.074385122955, 4630.328602352673, 6816.897746533806, 6842.589444633338, 6842.931570684279, 6851.760188393432, 6854.520183587151, 4712.69367491112, 4712.740799256006, 4723.149833030019, 4723.315119307681, 4729.527047295243, 4773.498782627844, 4779.856604301876, 4780.020095880336, 4782.856514304576, 4787.4494433140635, 5462.235287059815, 5473.917891231635, 5480.80817171405, 5491.093969494988, 5507.752151153208, 6471.7734879279, 6617.437517810944, 6653.301403352675, 6662.100616416722, 6681.298463661343, 1608.0191083439092, 1625.8943168693997, 1632.9183540823149, 1636.0347395036986, 1637.2223193982763, 1019.9031092046243, 1034.8240799064176, 1041.3803786746873, 1057.8730552333616, 1059.3961441978154, 6266.49868010558, 6513.511486638521, 6524.64114473699, 6526.902096468557, 6531.836704082436, 6910.896336554955, 6916.723331066701, 6929.237783843773, 6929.480288978246, 6935.895961560581, 6498.675066246668, 6504.089427480157, 6513.576617519846, 6515.153030106056, 6516.218053833571, 3699.8335074921692, 3723.795191264452, 3737.0470530014672, 3741.1769410729594, 3744.2324323513612, 6977.686004129826, 7136.0, 7163.31948464895, 7183.748568800067, 7224.096987876515, 7075.2570980047385, 7088.291170882871, 7091.432685385157, 7091.574505529685, 7091.716331346792, 7148.571085734872, 7205.855882882418, 7209.747658831916, 7211.1707153678, 7215.49491535598, 6920.861582768417, 6925.099737034153, 6925.342092501204, 6927.168739751262, 6932.722691092502, 6573.474122070127, 6774.525783195129, 6827.6244806536115, 6844.5208835381045, 6861.313868613099, 7195.244499327495, 7203.71185152588, 7212.603306818175, 7218.747343843151, 7226.205117437183, 4617.561331673485, 4646.767661616973, 4652.883677908079, 4654.511276315938, 4654.86035418938, 6890.689918953759, 6911.965440172969, 6912.4815638826285, 6913.0, 6914.51598388108, 6545.901811472737, 6745.865082698417, 6748.93251067483, 6754.358335958076, 6756.459483241427, 6644.036614690746, 6686.7993960181275, 6689.030090636733, 6693.364130407604, 6699.564528305645, 6581.605103693793, 6583.30875258091, 6593.538452308292, 6597.0, 6602.735890564516, 6748.763793267212, 6751.122354093936, 6755.0, 6758.4931130166415, 6758.560693554903, 6448.9032664511005, 6595.340465953366, 6601.075849381186, 6602.207735071822, 6605.768798092044], "value": 5001.250066301564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7256028989127, 748.1321666866436, 757.3827330725459, 762.8207371267755, 781.6170076662434, 14678.266086695663, 15009.174495402749, 15013.474528391494, 15022.323995420205, 15050.322735476902, 12855.80716289254, 12966.611001669942, 12991.935040324784, 13004.089713720043, 13013.674658133528, 542.5388419843131, 586.3696526234294, 595.1429940885133, 598.9580729348947, 599.0804115682429, 605.8727667189895, 605.9484943779784, 609.3266940031268, 609.7073404765715, 610.2920612089977, 556.3935310511541, 628.946539544137, 631.5326658272891, 635.2789583822349, 636.5321488705821, 624.3631495874206, 625.4964753373532, 626.589583822597, 626.7555653295218, 627.3882964110002, 459.68511569574946, 460.19925329926025, 461.21823509152, 463.5017356341912, 465.13252783558755, 13496.93251533746, 13526.864731352658, 13527.729445411036, 13531.797023044663, 13575.321233938264, 13102.344882755919, 13852.93073534636, 13884.542945121453, 14395.0, 14523.346449409803, 11390.829137562943, 11412.828807567894, 12057.638270851889, 12133.575324863676, 12340.81488777669, 3931.5282166140246, 3989.8204580793645, 4004.439378487014, 4009.719319647626, 4022.5776293489057, 51550.484495154946, 51996.48003519954, 52557.0, 54470.72764636151, 57389.843558604676, 10669.0, 11092.279001864854, 11183.552657893593, 11359.375234362024, 11750.529978800752, 17372.913135434243, 17481.388151414892, 17748.645027099385, 17758.644827103384, 17770.289188432576, 8229.300509456643, 8384.832303353898, 8401.95799021001, 8522.78693032679, 8561.357898157663, 5108.693478391308, 5114.130597798308, 5126.128558145124, 5143.717095559706, 5222.086134926372, 3323.069540528656, 3379.2227787608986, 3380.5098260752543, 3382.1206486313736, 3390.118569171984, 585.912113183026, 626.029654036242, 656.4485831901226, 658.3219284137347, 664.4717449627558, 716.8888822232562, 726.4914559808155, 742.8142964258935, 746.2500187311825, 746.6341492668553, 9004.50475223856, 9256.603530153088, 9321.30090243221, 9724.027597240362, 10175.0, 710.9822254443577, 724.5362967700676, 726.8037629840019, 732.4323649171935, 749.9850003000018, 4245.0, 4314.870553883388, 4315.115401342718, 4320.503142138631, 4375.890602734893, 63214.68392658099, 63772.0, 64561.0, 64814.35185648177, 65017.0, 53080.469195308324, 54190.45809541933, 55122.17316740252, 55609.72195138998, 56188.157177642366, 50087.49912500901, 50861.23708144381, 51028.489715102376, 51474.22788658173, 51903.740481298104, 10204.662449258803, 10398.376097434179, 10407.791844162923, 10420.583176673152, 10448.738781530523, 38540.0, 38796.41805372865, 39490.40764388594, 39577.802110990415, 39812.3050043679, 43806.34290485709, 44723.32915006342, 45770.771146144056, 48382.5161748378, 48396.75801620969, 11341.0, 11355.37545435009, 11509.53961841517, 11616.593419230287, 11849.822252666045, 13575.728485430434, 13851.0, 13882.0, 13947.814435773073, 14269.714605708035, 11561.364124972872, 12743.044271679475, 13318.600441986757, 13645.795313070113, 13958.511452099128, 13441.327933603476, 13688.0, 13705.657358566115, 13800.654983625089, 13849.723005539632, 13405.731885362433, 13528.661783455493, 13532.255725935169, 13677.384517696528, 13741.656458588215, 11327.15046371542, 11431.199816012799, 11462.541498339973, 11524.13568982313, 11935.76128477443, 10909.727256818644, 11241.494132764208, 11374.772504550028, 11414.543418263176, 11583.305001699924], "value": 6597.209087862669, "unit": "score"}], "name": "dromaeo_css", "value": 7228.281080321733, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 110.0, 112.0, 109.0, 105.0, 109.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 152.0, 188.0, 129.0, 159.0, 158.0, 134.0, 206.0, 138.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 164.0, 77.0, 77.0, 77.0, 76.0, 160.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 155.0, 93.0, 91.0, 93.0, 154.0, 92.0, 93.0, 147.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 56.0, 54.0, 55.0, 72.0, 54.0, 52.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 73.0, 75.0, 73.0, 74.0, 74.0, 74.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 110.0, 113.0, 114.0, 112.0, 112.0, 121.0, 127.0, 123.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 158.0, 158.0, 159.0, 161.0, 156.0, 166.0, 164.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 67.0, 76.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1519.9, "alertThreshold": 2.0}]} 03:31:49 INFO - Return code: 0 03:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:31:49 ERROR - # TBPL SUCCESS # 03:31:49 INFO - Running post-action listener: _resource_record_post_action 03:31:49 INFO - Running post-run listener: _resource_record_post_run 03:31:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 496713728; Read time: 48; Write time: 587596 03:31:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 203378688; Read time: 0; Write time: 305332 03:31:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 270336; Write bytes: 247549952; Read time: 48; Write time: 264884 03:31:50 INFO - Running post-run listener: _upload_blobber_files 03:31:50 INFO - Blob upload gear active. 03:31:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:50 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:31:50 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:31:50 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:31:51 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:52 INFO - (blobuploader) - INFO - Done attempting. 03:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:53 INFO - (blobuploader) - INFO - Done attempting. 03:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:53 INFO - Return code: 0 03:31:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e202feec0234d284c94efba8d76e38a970acf10823fcb2d218866ccc10202d2afb8ede9c48bb5192452ee3be59d06efd28a3ee1326b01de475e0623895cbbefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6002027c85e6b6fc36349045ad2a3161a28e1be816c00d102e4acf30d30e9a9d940bd5a173b85790b5c3a08103615fcd57a755782d3b5922049c548b3f89864"} 03:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:53 INFO - Contents: 03:31:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e202feec0234d284c94efba8d76e38a970acf10823fcb2d218866ccc10202d2afb8ede9c48bb5192452ee3be59d06efd28a3ee1326b01de475e0623895cbbefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6002027c85e6b6fc36349045ad2a3161a28e1be816c00d102e4acf30d30e9a9d940bd5a173b85790b5c3a08103615fcd57a755782d3b5922049c548b3f89864"} 03:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:53 INFO - Copying logs to upload dir... 03:31:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.273929 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-28 03:31:53.238959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:53.242942) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e202feec0234d284c94efba8d76e38a970acf10823fcb2d218866ccc10202d2afb8ede9c48bb5192452ee3be59d06efd28a3ee1326b01de475e0623895cbbefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6002027c85e6b6fc36349045ad2a3161a28e1be816c00d102e4acf30d30e9a9d940bd5a173b85790b5c3a08103615fcd57a755782d3b5922049c548b3f89864"} build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e202feec0234d284c94efba8d76e38a970acf10823fcb2d218866ccc10202d2afb8ede9c48bb5192452ee3be59d06efd28a3ee1326b01de475e0623895cbbefa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6002027c85e6b6fc36349045ad2a3161a28e1be816c00d102e4acf30d30e9a9d940bd5a173b85790b5c3a08103615fcd57a755782d3b5922049c548b3f89864"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:53.270098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:53.270440) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464430281.414335-1630214567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:53.355370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:53.355697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:53.355991) ========= ========= Total master_lag: 0.17 =========