builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1464648648.52 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.518826) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.519186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.519462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.601283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.601544) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 15:50:49-- 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% 38.2M=0s 2016-05-30 15:50:49 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128631 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.757283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.757573) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.809660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:48.810158) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 15:50:49,277 truncating revision to first 12 chars 2016-05-30 15:50:49,277 Setting DEBUG logging. 2016-05-30 15:50:49,277 attempt 1/10 2016-05-30 15:50:49,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 15:50:49,661 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.559628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.559941) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.560339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.560621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 15:50:49.569957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-30 15:50:49.570240) ========= /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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:50 INFO - MultiFileLogger online at 20160530 15:50:50 in /builds/slave/test 15:50:50 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 15:50:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:50 INFO - {'append_to_log': False, 15:50:50 INFO - 'base_work_dir': '/builds/slave/test', 15:50:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:50 INFO - 'branch': 'Mozilla-Aurora', 15:50:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:50 INFO - 'config_files': ('talos/linux_config.py',), 15:50:50 INFO - 'default_actions': ('clobber', 15:50:50 INFO - 'read-buildbot-config', 15:50:50 INFO - 'download-and-extract', 15:50:50 INFO - 'populate-webroot', 15:50:50 INFO - 'create-virtualenv', 15:50:50 INFO - 'install', 15:50:50 INFO - 'run-tests'), 15:50:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:50 INFO - 'download_minidump_stackwalk': True, 15:50:50 INFO - 'download_symbols': 'ondemand', 15:50:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:50 INFO - 'installer_path': 'installer.exe', 15:50:50 INFO - 'log_level': 'info', 15:50:50 INFO - 'log_name': 'talos', 15:50:50 INFO - 'log_to_console': True, 15:50:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:50 INFO - 'opt_config_files': (), 15:50:50 INFO - 'pip_index': False, 15:50:50 INFO - 'sps_profile': False, 15:50:50 INFO - 'sps_profile_interval': 0, 15:50:50 INFO - 'suite': 'dromaeojs', 15:50:50 INFO - 'system_bits': '32', 15:50:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:50 INFO - 'title': 'talos-linux64-ix-014', 15:50:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:50 INFO - 'use_talos_json': True, 15:50:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:50 INFO - 'work_dir': 'build'} 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running clobber step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: clobber 15:50:50 INFO - rmtree: /builds/slave/test/build 15:50:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:51 INFO - Running post-action listener: _resource_record_post_action 15:50:51 INFO - ##### 15:50:51 INFO - ##### Running read-buildbot-config step. 15:50:51 INFO - ##### 15:50:51 INFO - Running pre-action listener: _resource_record_pre_action 15:50:51 INFO - Running main action method: read_buildbot_config 15:50:51 INFO - Using buildbot properties: 15:50:51 INFO - { 15:50:51 INFO - "project": "", 15:50:51 INFO - "product": "firefox", 15:50:51 INFO - "script_repo_revision": "production", 15:50:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:50:51 INFO - "repository": "", 15:50:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:50:51 INFO - "buildid": "20160530120549", 15:50:51 INFO - "pgo_build": "True", 15:50:51 INFO - "basedir": "/builds/slave/test", 15:50:51 INFO - "buildnumber": 351, 15:50:51 INFO - "slavename": "talos-linux64-ix-014", 15:50:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:51 INFO - "platform": "ubuntu64_hw", 15:50:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:50:51 INFO - "branch": "mozilla-aurora", 15:50:51 INFO - "repo_path": "releases/mozilla-aurora", 15:50:51 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 15:50:51 INFO - "stage_platform": "linux64-pgo", 15:50:51 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 15:50:51 INFO - "slavebuilddir": "test" 15:50:51 INFO - } 15:50:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:50:51 INFO - Running post-action listener: _resource_record_post_action 15:50:51 INFO - ##### 15:50:51 INFO - ##### Running download-and-extract step. 15:50:51 INFO - ##### 15:50:51 INFO - Running pre-action listener: _resource_record_pre_action 15:50:51 INFO - Running main action method: download_and_extract 15:50:51 INFO - mkdir: /builds/slave/test/build/tests 15:50:51 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')]} 15:50:51 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:57 INFO - Downloaded 1361 bytes. 15:50:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:50:57 INFO - Using the following test package requirements: 15:50:57 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:57 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:57 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:50:57 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'jsshell-linux-x86_64.zip'], 15:50:57 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:57 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:50:57 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:50:57 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:50:57 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:57 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:50:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:57 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:57 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:01 INFO - Downloaded 24173994 bytes. 15:51:01 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'] 15:51:01 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 15:51:03 INFO - Return code: 0 15:51:03 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 15:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:03 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:04 INFO - Downloaded 24173994 bytes. 15:51:04 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'] 15:51:04 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 15:51:06 INFO - Return code: 0 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:07 INFO - Downloaded 10840145 bytes. 15:51:07 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'] 15:51:07 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 15:51:07 INFO - Return code: 0 15:51:07 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')]} 15:51:07 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/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 15:51:09 INFO - Downloaded 62800628 bytes. 15:51:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:09 INFO - mkdir: /builds/slave/test/properties 15:51:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:09 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:09 INFO - Contents: 15:51:09 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:51:09 INFO - Running post-action listener: _resource_record_post_action 15:51:09 INFO - Running post-action listener: set_extra_try_arguments 15:51:09 INFO - ##### 15:51:09 INFO - ##### Running populate-webroot step. 15:51:09 INFO - ##### 15:51:09 INFO - Running pre-action listener: _resource_record_pre_action 15:51:09 INFO - Running main action method: populate_webroot 15:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:09 INFO - '--tppagecycles', 15:51:09 INFO - '7'], 15:51:09 INFO - 'tests': ['tsvgm']}}, 15:51:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['damp', 'tps']}, 15:51:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'tests': ['damp', 'tps']}, 15:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['dromaeo_dom']}, 15:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['a11yr', 15:51:09 INFO - 'ts_paint', 15:51:09 INFO - 'tpaint', 15:51:09 INFO - 'sessionrestore', 15:51:09 INFO - 'sessionrestore_no_auto_restore', 15:51:09 INFO - 'tabpaint']}, 15:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['tsvgx', 15:51:09 INFO - 'tsvgr_opacity', 15:51:09 INFO - 'tart', 15:51:09 INFO - 'tscrollx', 15:51:09 INFO - 'cart']}, 15:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:09 INFO - 'tsvgr_opacity', 15:51:09 INFO - 'tart', 15:51:09 INFO - 'tscrollx', 15:51:09 INFO - 'cart']}, 15:51:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'talos_options': ['--disable-e10s'], 15:51:09 INFO - 'tests': ['tp5o']}, 15:51:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'tests': ['tp5o']}, 15:51:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'talos_options': ['--disable-e10s', 15:51:09 INFO - '--xperf_path', 15:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:09 INFO - 'tests': ['tp5n']}, 15:51:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:09 INFO - 'talos_options': ['--xperf_path', 15:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:09 INFO - 'tests': ['tp5n']}}, 15:51:09 INFO - 'talos.zip': {'path': '', 15:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:09 INFO - Running post-action listener: _resource_record_post_action 15:51:09 INFO - ##### 15:51:09 INFO - ##### Running create-virtualenv step. 15:51:09 INFO - ##### 15:51:09 INFO - Running pre-action listener: _resource_record_pre_action 15:51:09 INFO - Running main action method: create_virtualenv 15:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:09 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 15:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:09 INFO - Using real prefix '/usr' 15:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:12 INFO - Installing pip.................done. 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:12 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 15:51:12 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 15:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 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 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:12 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 15:51:12 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 15:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Downloading/unpacking psutil>=0.7.1 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:14 INFO - Installing collected packages: psutil 15:51:14 INFO - Running setup.py install for psutil 15:51:14 INFO - building 'psutil._psutil_linux' extension 15:51:14 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 15:51:15 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 15:51:15 INFO - building 'psutil._psutil_posix' extension 15:51:15 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 15:51:15 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 15:51:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:15 INFO - Successfully installed psutil 15:51:15 INFO - Cleaning up... 15:51:15 INFO - Return code: 0 15:51:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:15 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')]} 15:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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')]} 15:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:15 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:15 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 15:51:15 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 15:51:15 INFO - Using env: {'DISPLAY': ':0', 15:51:15 INFO - 'HOME': '/home/cltbld', 15:51:15 INFO - 'LANG': 'en_US.UTF-8', 15:51:15 INFO - 'LANGUAGE': 'en_US:en', 15:51:15 INFO - 'LOGNAME': 'cltbld', 15:51:15 INFO - 'MAIL': '/var/mail/cltbld', 15:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:15 INFO - 'MOZ_NO_REMOTE': '1', 15:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:15 INFO - 'NO_EM_RESTART': '1', 15:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:15 INFO - 'PWD': '/builds/slave/test', 15:51:15 INFO - 'SHELL': '/bin/bash', 15:51:15 INFO - 'SHLVL': '1', 15:51:15 INFO - 'TERM': 'linux', 15:51:15 INFO - 'TMOUT': '86400', 15:51:15 INFO - 'USER': 'cltbld', 15:51:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:15 INFO - '_': '/tools/buildbot/bin/python'} 15:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:15 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 15:51:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:17 INFO - Installing collected packages: mozsystemmonitor 15:51:17 INFO - Running setup.py install for mozsystemmonitor 15:51:17 INFO - Successfully installed mozsystemmonitor 15:51:17 INFO - Cleaning up... 15:51:17 INFO - Return code: 0 15:51:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:17 INFO - Using env: {'DISPLAY': ':0', 15:51:17 INFO - 'HOME': '/home/cltbld', 15:51:17 INFO - 'LANG': 'en_US.UTF-8', 15:51:17 INFO - 'LANGUAGE': 'en_US:en', 15:51:17 INFO - 'LOGNAME': 'cltbld', 15:51:17 INFO - 'MAIL': '/var/mail/cltbld', 15:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:17 INFO - 'MOZ_NO_REMOTE': '1', 15:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:17 INFO - 'NO_EM_RESTART': '1', 15:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:17 INFO - 'PWD': '/builds/slave/test', 15:51:17 INFO - 'SHELL': '/bin/bash', 15:51:17 INFO - 'SHLVL': '1', 15:51:17 INFO - 'TERM': 'linux', 15:51:17 INFO - 'TMOUT': '86400', 15:51:17 INFO - 'USER': 'cltbld', 15:51:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:17 INFO - '_': '/tools/buildbot/bin/python'} 15:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 INFO - Downloading docopt-0.6.1.tar.gz 15:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:20 INFO - Running setup.py install for blobuploader 15:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:20 INFO - Running setup.py install for requests 15:51:20 INFO - Running setup.py install for docopt 15:51:21 INFO - Successfully installed blobuploader requests docopt 15:51:21 INFO - Cleaning up... 15:51:21 INFO - Return code: 0 15:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:21 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 15:51:21 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 15:51:21 INFO - Using env: {'DISPLAY': ':0', 15:51:21 INFO - 'HOME': '/home/cltbld', 15:51:21 INFO - 'LANG': 'en_US.UTF-8', 15:51:21 INFO - 'LANGUAGE': 'en_US:en', 15:51:21 INFO - 'LOGNAME': 'cltbld', 15:51:21 INFO - 'MAIL': '/var/mail/cltbld', 15:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:21 INFO - 'MOZ_NO_REMOTE': '1', 15:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:21 INFO - 'NO_EM_RESTART': '1', 15:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:21 INFO - 'PWD': '/builds/slave/test', 15:51:21 INFO - 'SHELL': '/bin/bash', 15:51:21 INFO - 'SHLVL': '1', 15:51:21 INFO - 'TERM': 'linux', 15:51:21 INFO - 'TMOUT': '86400', 15:51:21 INFO - 'USER': 'cltbld', 15:51:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:21 INFO - '_': '/tools/buildbot/bin/python'} 15:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:21 INFO - Running setup.py (path:/tmp/pip-s6pFw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:21 INFO - Running setup.py (path:/tmp/pip-S36Dom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:21 INFO - Running setup.py (path:/tmp/pip-lT5bB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:21 INFO - Running setup.py (path:/tmp/pip-KQuhrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:21 INFO - Running setup.py (path:/tmp/pip-XdqAq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:21 INFO - Running setup.py (path:/tmp/pip-238miM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:21 INFO - Running setup.py (path:/tmp/pip-YwEDEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:21 INFO - Running setup.py (path:/tmp/pip-dYfxGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:21 INFO - Running setup.py (path:/tmp/pip-32XUjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:22 INFO - Running setup.py (path:/tmp/pip-2G7gaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:22 INFO - Running setup.py (path:/tmp/pip-QgZsgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:22 INFO - Running setup.py (path:/tmp/pip-MhN8n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:22 INFO - Running setup.py (path:/tmp/pip-vvGA5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:22 INFO - Running setup.py (path:/tmp/pip-Fw8i1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:22 INFO - Running setup.py (path:/tmp/pip-3lQk6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:22 INFO - Running setup.py (path:/tmp/pip-cpOcda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:22 INFO - Running setup.py (path:/tmp/pip-4hvhsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:22 INFO - Running setup.py install for manifestparser 15:51:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Running setup.py install for mozcrash 15:51:22 INFO - Running setup.py install for mozdebug 15:51:22 INFO - Running setup.py install for mozdevice 15:51:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozfile 15:51:23 INFO - Running setup.py install for mozhttpd 15:51:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozinfo 15:51:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozInstall 15:51:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozleak 15:51:23 INFO - Running setup.py install for mozlog 15:51:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for moznetwork 15:51:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozprocess 15:51:23 INFO - Running setup.py install for mozprofile 15:51:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozrunner 15:51:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:24 INFO - Running setup.py install for mozscreenshot 15:51:24 INFO - Running setup.py install for moztest 15:51:24 INFO - Running setup.py install for mozversion 15:51:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:24 INFO - Cleaning up... 15:51:24 INFO - Return code: 0 15:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:24 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 15:51:24 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 15:51:24 INFO - Using env: {'DISPLAY': ':0', 15:51:24 INFO - 'HOME': '/home/cltbld', 15:51:24 INFO - 'LANG': 'en_US.UTF-8', 15:51:24 INFO - 'LANGUAGE': 'en_US:en', 15:51:24 INFO - 'LOGNAME': 'cltbld', 15:51:24 INFO - 'MAIL': '/var/mail/cltbld', 15:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:24 INFO - 'MOZ_NO_REMOTE': '1', 15:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:24 INFO - 'NO_EM_RESTART': '1', 15:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:24 INFO - 'PWD': '/builds/slave/test', 15:51:24 INFO - 'SHELL': '/bin/bash', 15:51:24 INFO - 'SHLVL': '1', 15:51:24 INFO - 'TERM': 'linux', 15:51:24 INFO - 'TMOUT': '86400', 15:51:24 INFO - 'USER': 'cltbld', 15:51:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:24 INFO - '_': '/tools/buildbot/bin/python'} 15:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:24 INFO - Running setup.py (path:/tmp/pip-7lL4Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:24 INFO - Running setup.py (path:/tmp/pip-lqZBnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:24 INFO - Running setup.py (path:/tmp/pip-7J2_op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:24 INFO - Running setup.py (path:/tmp/pip-Hfa0El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:24 INFO - Running setup.py (path:/tmp/pip-Q7irxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:24 INFO - Running setup.py (path:/tmp/pip-UNhtq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:25 INFO - Running setup.py (path:/tmp/pip-QB24Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:25 INFO - Running setup.py (path:/tmp/pip-xVcLnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:25 INFO - Running setup.py (path:/tmp/pip-9GFZ1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:25 INFO - Running setup.py (path:/tmp/pip-RrM8de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:25 INFO - Running setup.py (path:/tmp/pip-kmdGXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:25 INFO - Running setup.py (path:/tmp/pip-aTXUeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:25 INFO - Running setup.py (path:/tmp/pip-ZGA6AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:25 INFO - Running setup.py (path:/tmp/pip-lI9cio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:25 INFO - Running setup.py (path:/tmp/pip-tIqL4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:25 INFO - Running setup.py (path:/tmp/pip-E7vWUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:25 INFO - Running setup.py (path:/tmp/pip-9sLSD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:25 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)) 15:51:25 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)) 15:51:25 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)) 15:51:25 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)) 15:51:25 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)) 15:51:25 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)) 15:51:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:27 INFO - Downloading blessings-1.6.tar.gz 15:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:27 INFO - Installing collected packages: blessings 15:51:27 INFO - Running setup.py install for blessings 15:51:27 INFO - Successfully installed blessings 15:51:27 INFO - Cleaning up... 15:51:27 INFO - Return code: 0 15:51:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:28 INFO - Reading from file tmpfile_stdout 15:51:28 INFO - Current package versions: 15:51:28 INFO - argparse == 1.2.1 15:51:28 INFO - blessings == 1.6 15:51:28 INFO - blobuploader == 1.2.4 15:51:28 INFO - docopt == 0.6.1 15:51:28 INFO - manifestparser == 1.1 15:51:28 INFO - mozInstall == 1.12 15:51:28 INFO - mozcrash == 0.17 15:51:28 INFO - mozdebug == 0.1 15:51:28 INFO - mozdevice == 0.48 15:51:28 INFO - mozfile == 1.2 15:51:28 INFO - mozhttpd == 0.7 15:51:28 INFO - mozinfo == 0.9 15:51:28 INFO - mozleak == 0.1 15:51:28 INFO - mozlog == 3.1 15:51:28 INFO - moznetwork == 0.27 15:51:28 INFO - mozprocess == 0.22 15:51:28 INFO - mozprofile == 0.28 15:51:28 INFO - mozrunner == 6.11 15:51:28 INFO - mozscreenshot == 0.1 15:51:28 INFO - mozsystemmonitor == 0.0 15:51:28 INFO - moztest == 0.7 15:51:28 INFO - mozversion == 1.4 15:51:28 INFO - psutil == 3.1.1 15:51:28 INFO - requests == 1.2.3 15:51:28 INFO - wsgiref == 0.1.2 15:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:28 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 15:51:28 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 15:51:28 INFO - Using env: {'DISPLAY': ':0', 15:51:28 INFO - 'HOME': '/home/cltbld', 15:51:28 INFO - 'LANG': 'en_US.UTF-8', 15:51:28 INFO - 'LANGUAGE': 'en_US:en', 15:51:28 INFO - 'LOGNAME': 'cltbld', 15:51:28 INFO - 'MAIL': '/var/mail/cltbld', 15:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:28 INFO - 'MOZ_NO_REMOTE': '1', 15:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:28 INFO - 'NO_EM_RESTART': '1', 15:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:28 INFO - 'PWD': '/builds/slave/test', 15:51:28 INFO - 'SHELL': '/bin/bash', 15:51:28 INFO - 'SHLVL': '1', 15:51:28 INFO - 'TERM': 'linux', 15:51:28 INFO - 'TMOUT': '86400', 15:51:28 INFO - 'USER': 'cltbld', 15:51:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:28 INFO - '_': '/tools/buildbot/bin/python'} 15:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:28 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 15:51:28 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 15:51:28 INFO - Using env: {'DISPLAY': ':0', 15:51:28 INFO - 'HOME': '/home/cltbld', 15:51:28 INFO - 'LANG': 'en_US.UTF-8', 15:51:28 INFO - 'LANGUAGE': 'en_US:en', 15:51:28 INFO - 'LOGNAME': 'cltbld', 15:51:28 INFO - 'MAIL': '/var/mail/cltbld', 15:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:28 INFO - 'MOZ_NO_REMOTE': '1', 15:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:28 INFO - 'NO_EM_RESTART': '1', 15:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:28 INFO - 'PWD': '/builds/slave/test', 15:51:28 INFO - 'SHELL': '/bin/bash', 15:51:28 INFO - 'SHLVL': '1', 15:51:28 INFO - 'TERM': 'linux', 15:51:28 INFO - 'TMOUT': '86400', 15:51:28 INFO - 'USER': 'cltbld', 15:51:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:28 INFO - '_': '/tools/buildbot/bin/python'} 15:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:28 INFO - Downloading/unpacking jsonschema 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:30 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:30 INFO - warning: no files found matching '*.txt' 15:51:30 INFO - no previously-included directories found matching 'build' 15:51:30 INFO - no previously-included directories found matching 'dist' 15:51:30 INFO - no previously-included directories found matching '.git*' 15:51:30 INFO - Installing collected packages: jsonschema, functools32 15:51:30 INFO - Running setup.py install for functools32 15:51:30 INFO - warning: no files found matching '*.txt' 15:51:30 INFO - no previously-included directories found matching 'build' 15:51:30 INFO - no previously-included directories found matching 'dist' 15:51:30 INFO - no previously-included directories found matching '.git*' 15:51:30 INFO - Successfully installed jsonschema functools32 15:51:30 INFO - Cleaning up... 15:51:30 INFO - Return code: 0 15:51:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:30 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')]} 15:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 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')]} 15:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 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 0x7fa1d7752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12df5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', '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 15:51:30 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 15:51:30 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 15:51:30 INFO - Using env: {'DISPLAY': ':0', 15:51:30 INFO - 'HOME': '/home/cltbld', 15:51:30 INFO - 'LANG': 'en_US.UTF-8', 15:51:30 INFO - 'LANGUAGE': 'en_US:en', 15:51:30 INFO - 'LOGNAME': 'cltbld', 15:51:30 INFO - 'MAIL': '/var/mail/cltbld', 15:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:30 INFO - 'MOZ_NO_REMOTE': '1', 15:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:30 INFO - 'NO_EM_RESTART': '1', 15:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:30 INFO - 'PWD': '/builds/slave/test', 15:51:30 INFO - 'SHELL': '/bin/bash', 15:51:30 INFO - 'SHLVL': '1', 15:51:30 INFO - 'TERM': 'linux', 15:51:30 INFO - 'TMOUT': '86400', 15:51:30 INFO - 'USER': 'cltbld', 15:51:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:30 INFO - '_': '/tools/buildbot/bin/python'} 15:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:31 INFO - Downloading/unpacking flake8 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:33 INFO - no previously-included directories found matching 'docs/_build' 15:51:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:33 INFO - Running setup.py install for pep8 15:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:33 INFO - no previously-included directories found matching 'docs/_build' 15:51:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:33 INFO - Cleaning up... 15:51:34 INFO - Return code: 0 15:51:34 INFO - Running post-action listener: _resource_record_post_action 15:51:34 INFO - Running post-action listener: _start_resource_monitoring 15:51:34 INFO - Starting resource monitoring. 15:51:34 INFO - ##### 15:51:34 INFO - ##### Running install step. 15:51:34 INFO - ##### 15:51:34 INFO - Running pre-action listener: _resource_record_pre_action 15:51:34 INFO - Running main action method: install 15:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:34 INFO - Reading from file tmpfile_stdout 15:51:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:34 INFO - Reading from file tmpfile_stdout 15:51:34 INFO - Output received: 15:51:34 INFO - Usage: mozinstall [options] installer 15:51:34 INFO - Options: 15:51:34 INFO - -h, --help show this help message and exit 15:51:34 INFO - -d DEST, --destination=DEST 15:51:34 INFO - Directory to install application into. [default: 15:51:34 INFO - "/builds/slave/test"] 15:51:34 INFO - --app=APP Application being installed. [default: firefox] 15:51:34 INFO - mkdir: /builds/slave/test/build/application 15:51:34 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'] 15:51:34 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 15:51:49 INFO - Reading from file tmpfile_stdout 15:51:49 INFO - Output received: 15:51:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:49 INFO - Running post-action listener: _resource_record_post_action 15:51:49 INFO - ##### 15:51:49 INFO - ##### Running run-tests step. 15:51:49 INFO - ##### 15:51:49 INFO - Running pre-action listener: _resource_record_pre_action 15:51:49 INFO - Running main action method: run_tests 15:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:49 INFO - Python 2.7.3 15:51:49 INFO - Return code: 0 15:51:49 INFO - grabbing minidump binary from tooltool 15:51: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')]} 15:51:49 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 0x136e410>, '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 0x136f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:49 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 15:51:49 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 15:51:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:50 INFO - Return code: 0 15:51:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:50 INFO - Return code: 0 15:51:50 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 15:51:50 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 15:51:50 INFO - Using env: {'DISPLAY': ':0', 15:51:50 INFO - 'HOME': '/home/cltbld', 15:51:50 INFO - 'LANG': 'en_US.UTF-8', 15:51:50 INFO - 'LANGUAGE': 'en_US:en', 15:51:50 INFO - 'LOGNAME': 'cltbld', 15:51:50 INFO - 'MAIL': '/var/mail/cltbld', 15:51:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:50 INFO - 'MOZ_NO_REMOTE': '1', 15:51:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:50 INFO - 'NO_EM_RESTART': '1', 15:51:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:50 INFO - 'PWD': '/builds/slave/test', 15:51:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:50 INFO - 'SHELL': '/bin/bash', 15:51:50 INFO - 'SHLVL': '1', 15:51:50 INFO - 'TERM': 'linux', 15:51:50 INFO - 'TMOUT': '86400', 15:51:50 INFO - 'USER': 'cltbld', 15:51:50 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468', 15:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:50 INFO - '_': '/tools/buildbot/bin/python'} 15:51:50 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 15:51:51 INFO - mozversion application_buildid: 20160530120549 15:51:51 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:51:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:51 INFO - mozversion application_name: Firefox 15:51:51 INFO - mozversion application_remotingname: firefox-dev 15:51:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:51 INFO - mozversion application_vendor: Mozilla 15:51:51 INFO - mozversion application_version: 48.0a2 15:51:51 INFO - mozversion platform_buildid: 20160530120549 15:51:51 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 15:51:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:51:51 INFO - mozversion platform_version: 48.0a2 15:51:51 INFO - using testdate: 1464648711 15:51:51 INFO - actual date: 1464648711 15:51:51 INFO - starting webserver on 'localhost:56049' 15:51:51 INFO - SUITE-START | Running 2 tests 15:51:51 INFO - TEST-START | dromaeo_css 15:51:51 INFO - operating with platform_type : linux_ 15:51:51 INFO - Initialising browser for dromaeo_css test... 15:51:51 INFO - TEST-INFO | started process 26801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9wmX9p/profile http://localhost:56049/getInfo.html) 15:51:54 INFO - PROCESS | 26801 | __metrics Screen width/height:1600/1200 15:51:54 INFO - PROCESS | 26801 | colorDepth:24 15:51:54 INFO - PROCESS | 26801 | Browser inner width/height: 1024/697 15:51:54 INFO - PROCESS | 26801 | __metrics 15:51:56 ERROR - PROCESS | 26801 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:51:56 INFO - TEST-INFO | 26801: exit 0 15:51:56 INFO - Browser initialized. 15:51:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:56 INFO - TEST-INFO | started process 26891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9wmX9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:08 INFO - PROCESS | 26891 | RSS: Main: 142028800 15:52:08 INFO - PROCESS | 26891 | 15:52:59 INFO - PROCESS | 26891 | 1464648779741 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] 15:55:07 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56049/tests/dromaeo/cssquery-ext.html) 15:55:08 INFO - PROCESS | 26891 | RSS: Main: 253722624 15:55:08 INFO - PROCESS | 26891 | 15:58:10 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-ext.html (next: http://localhost:56049/tests/dromaeo/cssquery-jquery.html) 15:58:11 INFO - PROCESS | 26891 | RSS: Main: 228970496 15:58:11 INFO - PROCESS | 26891 | 16:01:12 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56049/tests/dromaeo/cssquery-mootools.html) 16:01:13 INFO - PROCESS | 26891 | RSS: Main: 220479488 16:01:13 INFO - PROCESS | 26891 | 16:04:15 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56049/tests/dromaeo/cssquery-prototype.html) 16:04:15 INFO - PROCESS | 26891 | RSS: Main: 220090368 16:04:15 INFO - PROCESS | 26891 | 16:07:18 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56049/tests/dromaeo/cssquery-yui.html) 16:07:18 INFO - PROCESS | 26891 | RSS: Main: 211853312 16:07:18 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | Cycle 1(1): loaded http://localhost:56049/tests/dromaeo/cssquery-yui.html (next: http://localhost:56049/tests/dromaeo/cssquery-dojo.html) 16:10:21 INFO - PROCESS | 26891 | RSS: Main: 256884736 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | __start_tp_report 16:10:21 INFO - PROCESS | 26891 | _x_x_mozilla_page_load 16:10:21 INFO - PROCESS | 26891 | _x_x_mozilla_page_load_details 16:10:21 INFO - PROCESS | 26891 | |i|pagename|runs| 16:10:21 INFO - PROCESS | 26891 | |0;dojo.html;3321.4851697986815;3364.226227967569;3373.055544447554;3395.2021275000384;3401.7958922464654;5593.692346920918;5624.015797235483;5646.971765141178;5668.43315668434;5686.402927692595;5632.07070833312;5684.488396044355;5685.260916080903;5691.203231547586;5693.8576535586635;4927.556519913207;5131.153359695655;5201.635885488017;5265.973670131663;5284.44513326101;5127.9230811537855;5165.276861239429;5165.896682066356;5172.09488339541;5173.637845350827;5081.060003899272;5088.669236499634;5158.638895277313;5166.974165129169;5178.5339319461245;5155.3040339554245;5173.9741301293625;5180.481951804846;5181.585473162176;5215.765290561933;4919.11455937931;5001.624878134155;5025.949740502585;5078.6698864574055;5095.923561146586;5414.160805075219;5463.754131064112;5475.7262136893;5499;5507.146392309199;5978.8505287367725;5997.100434934751;6005.699715014275;6011.819645410645;6015.428534289235;6028.788992385289;6053.122297266916;6117.583823141527;6133.1106989486725;6135.570510064297;5640.0693885508845;5678.290213723285;5679.943200567983;5683.687397193153;5686.3744988051285;6056.818295451144;6189;6194.0708893665405;6205.286392064971;6208.099825525273;5912.054071348563;5952.940470595238;5968.731407086691;5977.910331345033;5984.461398474158;6017.669028203403;6030.698465076729;6037.335893051761;6039.184710064173;6047.546434017467;5836.678982655994;5918.496927761103;5978.730957106941;5988.401159884064;5988.431099045583;5906.911396329058;5911.024680927685;5911.467967882825;5914.704264786744;5951.077582974646;4512.548745125461;4513.11994161142;4519.593236608721;4529.5243999380245;4549.249373853343;4040.252553277653;4044;4056.5334986476932;4081.734687245379;4103.4050062741335;5730.570207234474;5754.6547207167705;5758.539316854642;5760.251167348218;5779.595428319977;5993.250843644544;6046.606970546901;6048.274207095089;6050.57645964787;6052.515798736091;5654.06707893193;5689.402612725687;5701.173329867146;5729.627574207663;5751.798687045934;5119.897602047939;5126.743662816844;5128.205128205134;5129.230615407719;5131;6178.351273116348;6178.69106544671;6179.16581261533;6182.938170618326;6183.134361189437;5900.64596124234;5957.046872500552;6022.3977602241175;6029.246344206974;6042.637441753509;6201.906971395523;6202.472789812917;6205.503559715302;6225.408586184305;6228.065790131516;5790.305163380422;5894.557908156819;5902.203202567598;5916.852078698067;5943.851403714942;5943.346231914399;5994.790182343597;6006.09908513709;6007.639541627516;6029.216201893902;5800.50695690871;5845.649261044351;5847.912281315868;5850.297964244318;5855.2973643163095;5747.4252574742195;5760.884782304414;5807.883842323045;5830.883382332415;5843.474087332161;5687.402822703557;5688.971555142198;5689.658620482619;5703.030484817674;5719.342275638189;5781.219535362672;5784.8553786154;5785.971070144622;5811.186433899342;5823.94176058234;5658.094704847204;5678.517326027334;5696.743646535833;5739.62692424991;5746.712664366682 16:10:21 INFO - PROCESS | 26891 | |1;ext.html;673.6598018000909;674.2852576269158;687.529042605815;745.0649434959125;756.9402836029561;40655;41363.79318103405;41537.99999999996;41564.37653435193;41573.58426415735;44053.11893762131;44881;44882.77558612211;44922.326165107464;44984.3252351215;8018.438709290352;8787.384883058172;8977.057408972061;10400.687979360631;10609.522571484302;10342.482875856214;10460.686179414592;10469.16246700266;10469.371837689725;10473.633422830202;10458.947705261464;10506.947465262663;10526.157907367393;10541.578336866516;10544.367337959748;8227.300679442254;10440.112590429784;10606.310589811637;10611.522481488351;10621.25651204416;10566.471676416148;10685.679429617125;10687.358758474516;10688.572457101707;10693.358398496037;41714.58285417168;42193.36709949353;42214.577854221374;42262;42335.57664423347;3730.7015438764834;3837.194189220267;4073.5722749111214;4167.374893765929;4364.781760911974;34726.305473890636;35511.82244088789;35577.28845423077;35711.82144089289;35779.64220357815;4634.688832856947;4651.879848816385;4654.394928659286;4673.532646735333;4765.428148622187;339973;343259;345788;346230;346678;69683.65158174177;70654;70688.6465567669;70809.2919070813;70857;75257;75470.62264688751;76275.61862190765;76785;77125;17254.741178882326;18502.814971850108;18622.441326760218;18772.624547508975;18832.529186770167;13041.347932603332;13199.53801616958;13230.206187628773;13249.933750331187;13272.535461258809;21431.89284053601;21553;21605.45986350354;21663.458413539473;21719.782802171776;8040.67837286502;8209.58952052395;8223.54770487629;8224.38317126218;8461.534615596078;1054.5518154784186;1144.2219290882113;1146.696125526736;1202.2005366431226;1206.6983254186453;32753.78967609829;33361.332773344395;34164;34215;34351.484727729105;1206.5234232478122;1215.1554669504785;1222.0895432902544;1294.527497463419;1296.3453456004845;17372;17374.39189628357;17483.213255403538;17525.47423577295;17911.552211194823;501665;601081;606712;608354;610261;61799;62160;62516;62562.68718656377;62600.68699656473;1482.1255459278862;1495.6634757179547;1500.9943337963591;1506.4501456968346;1615.8949668271525;30198.54702179513;31550.684493154775;31829;31975;32710.34579308448;46352.53647463482;47069;47071.52928470672;47097.529024709314;47104.764476178774;280779;286618;287061;287069;287576;27208.455830883668;28369.43261134807;30186.396272073995;30455.695443045286;30833;42768.572314277706;42803.357949631405;43010.784946075066;43255.351169731846;43955.560444396426;35177.714594777026;39233;40692.38961415522;40810.1837963245;41161.176776464905;38638.42042369423;39390;40012.399814003395;40232.396514051725;40498.59501404948;40729;41548.1690366197;41571;41611.7919410401;41977;34463.65536344604;35811.82094089617;35828.104297392776;36001.81999089988;36434.27131457409;27479.450410992067;27936.30159246035;27986.8920386067;28087.578686320132;28176.85911570429 16:10:21 INFO - PROCESS | 26891 | |2;jquery.html;427.2501759412232;437.9408779814724;440.596853878701;443.9489458712247;452.4299382777699;18757.531061723446;18916.527086822836;19526.70709939352;20132.49668758278;20145.496362590944;19601.705974410394;19702.605947881035;20672.8966355168;20858.68711969318;20872;5696.1740547620675;5867.413258674141;5931.940680593182;6019.187409699678;6027.698615069251;4368.060866913613;5867.061270196769;5957.940420595782;6107.26712794463;6391.744330226786;6332.588381755171;6361.6183029018175;6373.617582945015;6375.10748495211;6379.07503412005;5743.5118014968775;6012.218411606507;6024.277086749575;6026.035834266497;6317.842053948642;3942.2706799242233;5623.240862483594;5851.64890106595;5869.50109240715;5897.675627840467;14231.857681423156;14360.928195359062;14409.639759006108;14484.565463036126;23376.298711038697;2484.7887929526014;2506.1103308325464;2517.4713310204697;2559.1554786920274;2657.946841063187;10284;10290.639827605997;10335.896641033569;10794.78410431787;10800.027997480185;1978.703194520819;2069.513664288906;2090.3833369156137;2098;2125.3517677108475;79961.60019199867;83558.58220708858;83679.5816020922;83728.58135709344;85089.14910850875;11278.605248816251;11423.942880285545;11467.655970320904;11564.190506664452;11658.6502404928;15776.13231272268;15908.92045539788;15943.920280398524;15945.920270398574;16004.91997540005;8524.147585241426;8545.487270763773;8565.528895910784;8603.741887743377;8641.654333826702;8361.372897032747;8382.49705017701;8603.655853765778;8689.695860644848;9172.495512746864;5071.619628527801;5196.76614552346;5200.349956255468;5218.843434696965;5255.106631872591;1860.451166905766;2008.3974807557674;2084.6247675418267;2089.613421517024;2163.8701677899376;1018.6689325969089;1105.160078340451;1134.1777211521746;1139.880312567185;1203.524607779922;17970.91014544919;18261.54346141357;18962.24151033943;19323.710144347846;19804;1041.7031146123318;1100.6147848253047;1101.5979167603766;1121.4897221764077;1134.6028889888637;10632.734181645521;11018.779624407467;11032.558697652164;11130.443477826077;11155.832662510069;565945;566015;589019;615496;616949;101311.49344253232;103501;106007.46996265123;106018.46990765151;106083;1156.2022204678744;1167.101331974392;1180.5513904716324;1189.0903458853984;1192.648168790209;16921.492355229362;16995.32018719287;17130.657386852443;17302.394416195373;17631.735523967407;39092;39186.412203817534;39954;40139;40497.392539111344;60544;60832.391676082676;61075.389246108745;61323;61851.909074144205;8770.868436973324;8999.910000899907;9065.864012039692;9105;9138.451692898447;10185.236107291834;13869.445222191;14043.648908777363;14111.858881411055;14249.572512824632;12275.754484910072;12471.189372690746;12570.245785252913;12583.748325033632;12684;11988.76022479563;12139.21095128849;12175.14773965814;12367.196132251374;12465;12321.322327271728;12348.567800126952;12578.811317830423;12664.74670506603;12818.487260509475;8850.291976641982;8866.778330541789;8891.822163556822;9022.278217742434;9127.680531181642;9256.028117047614;12445.75108497843;12572.497100115894;12685.873141268468;12903.612891613267 16:10:21 INFO - PROCESS | 26891 | |3;mootools.html;1428.9214093224869;1588.7537431698088;1597.3051722500709;1796.7035439152542;1938.8933608651528;8415.621297041633;8681.175288347597;8681.696140635078;8694.56527173642;8704.956475217623;8581.828363432727;8771.956140219307;8772.649094036231;8776.385653004292;8779.912200877989;2159.8920053997317;2438.6829712137487;2483.987580062097;2506.774390304872;2514.0446630280467;2470.4564995701007;2491.115653942851;2503.2740505253455;2503.5368456835545;2504.611785173292;2424.866632335221;2454.7054353477606;2455.9631605525933;2457.778799908008;2458.9877050614723;2177.1944380579207;2419.63705444183;2478.6901637295337;2480.119557557068;2484.565201089802;2304.9078036878673;2365.2431222008963;2365.8343915925893;2367.6922000140044;2368.7749663781915;8664;8701.47791132534;8773.868391974125;8775.341849361323;8791.78020549485;5196.402413722395;5272.235525848769;5294.894102117936;5311.760970756325;5376.704281264529;3444.362792883325;3520.7359448041243;3546.6453354664586;3549.4498352755363;3587.3004764071015;1140.766142940695;1167.9824802627968;1171.8476598042284;1183.6922400175931;1215.228330010441;11784.351860647661;11823.645290641294;11897.167198296123;11905;11908.821367679491;4787.832425865147;4853.19922212838;4853.95146048542;4862.489438608895;4908.3619129513645;10228.488575571191;10242.129418999319;10262.127719143808;10264.332818366931;10269.178465722724;4869.853904382874;5549.445055494499;5552.3892371839065;5555;5557.472040156179;5014.07239660664;5024.497550244946;5041.445441001487;5081.263216833612;5087.262346959744;4253.468316460442;4267.95435118398;4277.8288868444915;4292.8838501989085;4321.308590625485;1368.9520866769615;1392.5195807446414;1400.9019368644301;1416.129080615414;1418.9929050354683;918.1874041473344;1084.7938891610568;1110.1784679337393;1117.2626066795876;1120.0871289898869;6299.275583307886;6408.903866442007;6416.165898433173;6462.32145624712;6474.093626892239;515.0445922813202;518.2045560065282;1140.4183866228284;1156.306216270231;1176.211938001541;4145.316022856195;4164.5210800757695;4168.645665118499;4189.6229339359;4192.4759405074365;10471;10926.125909927347;10973.945130274298;11044.282121662067;11050.557977680963;10826.62106826273;10829.620963266249;10837.133029357632;10847.077998370227;10848.67453976382;8007.359411247203;8211.71259005932;8270.627821748036;8365.58172091393;8368.539730314891;6115.663638499926;6311.846232365788;6313.147725057059;6378.266499352449;6430.164078669743;9935.403875767477;9991.750206244611;10167.237457190593;10216;10276.691699249035;10189.643362482277;10324.380537167794;10329.225308102074;10468.528916198637;10574.947125264325;7048.118985126859;7500.437467189873;7594.126675432396;7757.573333466487;7796.922030779847;8663.653453862027;8683.392162548562;8704.651813927372;8766.211041006085;8776.692815751418;7624.313811756969;7743.683573792357;7816.960915195387;7859.253370929752;7988.720394786154;7622.5426474411715;7636.350910172698;7727.150013498398;7793.10379306387;7819;7353.117625884928;7355.411567074514;7368.778936631909;7402.592857392679;7405.44459165554;5263.289455923555;5342.332208473941;5407.540359069366;5472.261244731911;5510.366307874646;5151.0470562945975;5163.122269214167;5193.37679478465;5354.223637572608;5356.223347614497 16:10:21 INFO - PROCESS | 26891 | |4;prototype.html;343.560242889102;346.0949616752194;348.7698119241301;355.765194971319;360.59072952199256;6290.433860952513;6297.590656607323;6306.274778400485;6317.431431171193;6338.778142765004;5947.821565353035;6130.693465326727;6234.033724772657;6238.812835614927;6274.184356033721;4709.105269998689;4733.053389322132;4733.313669517918;4736.218523943562;4754.072955773626;4736.928946065795;4738.099761045408;4741.170295198343;4762.809487620509;4766.285057241407;4544.477385100723;4627.190241707704;4666.719996800186;4670.509596492353;4780.617550595944;4759.40507436567;4768.022555376174;4779.996200797819;4790.496997815214;4796.544328288807;4208.473940757405;4218.831246750157;4220.155968806251;4221.7255878367805;4222.9788851055855;5944.762209511614;5991.490723288525;5998.550108741862;6000.36996115406;6029.60807547508;5554.250176226198;5571.164325351189;5577.944220557783;5578.693171875586;5586.720663966786;6364.395382438661;6571.44142747867;6574.3754343337305;6583.572067815625;6588.341165883373;4626.421697287839;4680.555347242007;4693.178693728584;4695.060987802453;4702.224133018048;6851.623160726158;6859.965700171517;6860.554063985775;6865.485088618374;6868.244493105754;4799.160146974265;4807.831725889577;4808.35087263222;4809.759512024385;4812.1578723723205;4868.488808675109;4871.610271178297;4872.585830204473;4872.927955849707;4875.7074575525585;5288.391834938954;5451.209574611738;5489.039418101816;5579.860503487364;5582.665040097526;6598.274189839114;6634.402903738686;6635.469162466991;6641.66791660415;6645.833854153588;1640.9343626255054;1655.983440165607;1660.6512632347342;1660.9169541522876;1661.825508321633;1020.8877023527406;1078.1374900080061;1104.9613263535737;1105.8728246251785;1110.0342701849281;6321.589096708699;6326.272478665012;6345.650989195547;6347.047942808524;6418.133551970518;6778.72885084601;6783.694733736994;6786.151731033621;6793.728250870009;6796.932030679729;6411.198600174978;6412.64730439821;6413.711382987777;6418.935810641834;6428.132202152649;3596.8381422836037;3644.5079914211774;3647.0517665406655;3674.706023518112;3677.3564626190846;7035.894461583081;7048.859022819617;7061.046758687614;7068.151821781419;7074.186468556182;6887.345702158287;6895.55178913369;6901.965490172517;6914.274001229798;6916.619585922722;7054.894176587355;7060.258672839381;7063.940408938597;7068.68190931399;7069.611171385521;6681;6791.72833086671;6793.218779840382;6800.52396332252;6801.18385793708;6570.901436478553;6670.39966403026;6673.432758215606;6679.365460281266;6684.06423100776;7016.789496315118;7033.542819716907;7043.2604576518725;7045.753398631024;7069.71721131149;4663.720176789404;4669.509701481295;4669.7898594564;4684.414448193976;4687.367205427224;6769.221539523018;6788.898166527407;6793.354631310215;6795.694193761194;6806.115205023513;6433.742650293936;6567.704453299518;6579.671016449254;6582.078509008838;6589.47284217271;6464.935350646433;6530.314316996837;6548.901766473602;6565.080888675494;6570.77002304917;6470;6477.643729594917;6483.2544257411;6484.383983521558;6487.675616219264;6622.768203112868;6638.070670106285;6638.933610664025;6642.036904648896;6642.568233064835;6180.134781130555;6361.2048493938255;6475.708593113415;6542.018697195459;6542.476601871934 16:10:21 INFO - PROCESS | 26891 | |5;yui.html;914.6752902719533;925.4632313258311;938.118168921214;940.1022023967112;963.9903600963993;14006.22965736884;14189.361478733455;14191.645208869784;14240.287985600717;14292.285385730711;14534.854651453483;14590;14590.197539135343;14597.051191672534;14620.34208460619;753.6344872736719;768.2931702833407;770.2028400605375;770.3144201660526;899.9145081217307;913.853783394657;915.3455279475174;915.8946721127089;916.5508900638706;924.154398725169;970.3595626886256;970.403202030753;970.9368891022061;971.2909576009517;972.7373609125532;954.0459540459541;955.2167222877243;957.5355952363099;959.7264779537799;959.8608201810733;580.5703779203401;681.325487767107;690.730615060127;710.5026481462996;714.6712512244374;14645.853541464661;14662.780058299135;14687.853121468755;14697.33861976203;14730.410783568645;14013.719725605533;14504.347304371224;14673.706525869422;14684.118952862862;14765.18791466469;11211.439428028647;11294.491747871365;11477.139214558942;11531.827022594667;11572.95843374092;4068.3490641497515;4084.611961863618;4151.14901445206;4163.437935878648;4169.749815011109;54456;55386;55568.72215638936;55849.72075139639;56097.43902560963;12088.516459341703;12216.694582635506;12297;12329.568465103857;12403.875961240452;21528.13887444516;21559.56880862405;21576.56846863054;21583;21646.134154633954;8785.736427907173;8901.154390332907;8904.332175086894;9202.539873006323;9282.30382721285;4887.511248875155;5022.121128802445;5098.821541246039;5141.897162056738;5192.92210616841;3554.413521768879;3594.353016457063;3596.7302452315657;3606.098475381155;3606.386914224588;708.0971761004657;709.975150869717;716.802879208222;724.9927500724925;728.2717282717283;684.6610927590874;751.4101430377127;761.1437133225122;767.9232076792276;773.1495355109447;9244.491552964651;9893.406395616286;10053.396796192252;10205.285630005828;10495.842562361571;715.860407220587;794.3639875086254;816;834.4826207751233;836.1638361638362;4547.1815073287125;4567.771611419415;4583.335416364608;4593.150267200579;4728.598069164091;60700;65997.34002659912;66254.66872665606;66934.33065669281;67810.32189678139;58018;58807;59404.70297648484;59575;60218.39781602215;52242.738786305825;52310.73844630752;53066;53707;55792.999999999185;10165.593376264867;10203.150871000531;10229.84655230187;10413.57686756588;10418.426986515511;40104.197916042096;40612;40810.1837963245;40835.38746918858;41231.381529276485;50036.74981625069;50077.49922500728;50824.237636434744;53685.194722079985;55008;13549.254790986197;13569.389377477839;13766.587002389944;14462.710745785236;14510.782338264724;14167.149971001772;14506.637334066732;14706.191159485903;14805.703885922007;14837.851621484078;13949.721005579628;14208.715825683636;14209.50266740659;14609.707805843611;14826.332815023565;13721.931390342985;14502.492412765503;14844;14878.925605371904;15194.848051519344;14089.365978531196;14102.083364581269;14192;14398.496052638526;14657.56027319182;11240;11324.37715925632;11747.118966077407;11871.347075910908;11878.168528202943;11167.88832111701;11566.421678915853;11590.71023224426;11964.58123965657;12066.577669781516 16:10:21 INFO - PROCESS | 26891 | __end_tp_report 16:10:21 INFO - PROCESS | 26891 | __start_cc_report 16:10:21 INFO - PROCESS | 26891 | _x_x_mozilla_cycle_collect,910 16:10:21 INFO - PROCESS | 26891 | __end_cc_report 16:10:21 INFO - PROCESS | 26891 | __startTimestamp1464649821488__endTimestamp 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | ------- Summary: start ------- 16:10:21 INFO - PROCESS | 26891 | Number of tests: 6 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#0] dojo.html Cycles:165 Average:5574.13 Median:5754.65 stddev:620.40 (10.8%) stddev-sans-first:596.60 16:10:21 INFO - PROCESS | 26891 | Values: 3321.5 3364.2 3373.1 3395.2 3401.8 5593.7 5624.0 5647.0 5668.4 5686.4 5632.1 5684.5 5685.3 5691.2 5693.9 4927.6 5131.2 5201.6 5266.0 5284.4 5127.9 5165.3 5165.9 5172.1 5173.6 5081.1 5088.7 5158.6 5167.0 5178.5 5155.3 5174.0 5180.5 5181.6 5215.8 4919.1 5001.6 5025.9 5078.7 5095.9 5414.2 5463.8 5475.7 5499.0 5507.1 5978.9 5997.1 6005.7 6011.8 6015.4 6028.8 6053.1 6117.6 6133.1 6135.6 5640.1 5678.3 5679.9 5683.7 5686.4 6056.8 6189.0 6194.1 6205.3 6208.1 5912.1 5952.9 5968.7 5977.9 5984.5 6017.7 6030.7 6037.3 6039.2 6047.5 5836.7 5918.5 5978.7 5988.4 5988.4 5906.9 5911.0 5911.5 5914.7 5951.1 4512.5 4513.1 4519.6 4529.5 4549.2 4040.3 4044.0 4056.5 4081.7 4103.4 5730.6 5754.7 5758.5 5760.3 5779.6 5993.3 6046.6 6048.3 6050.6 6052.5 5654.1 5689.4 5701.2 5729.6 5751.8 5119.9 5126.7 5128.2 5129.2 5131.0 6178.4 6178.7 6179.2 6182.9 6183.1 5900.6 5957.0 6022.4 6029.2 6042.6 6201.9 6202.5 6205.5 6225.4 6228.1 5790.3 5894.6 5902.2 5916.9 5943.9 5943.3 5994.8 6006.1 6007.6 6029.2 5800.5 5845.6 5847.9 5850.3 5855.3 5747.4 5760.9 5807.9 5830.9 5843.5 5687.4 5689.0 5689.7 5703.0 5719.3 5781.2 5784.9 5786.0 5811.2 5823.9 5658.1 5678.5 5696.7 5739.6 5746.7 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#1] ext.html Cycles:180 Average:58365.60 Median:35644.55 stddev:113318.91 (317.9%) stddev-sans-first:113554.02 16:10:21 INFO - PROCESS | 26891 | Values: 673.7 674.3 687.5 745.1 756.9 40655.0 41363.8 41538.0 41564.4 41573.6 44053.1 44881.0 44882.8 44922.3 44984.3 8018.4 8787.4 8977.1 10400.7 10609.5 10342.5 10460.7 10469.2 10469.4 10473.6 10458.9 10506.9 10526.2 10541.6 10544.4 8227.3 10440.1 10606.3 10611.5 10621.3 10566.5 10685.7 10687.4 10688.6 10693.4 41714.6 42193.4 42214.6 42262.0 42335.6 3730.7 3837.2 4073.6 4167.4 4364.8 34726.3 35511.8 35577.3 35711.8 35779.6 4634.7 4651.9 4654.4 4673.5 4765.4 339973.0 343259.0 345788.0 346230.0 346678.0 69683.7 70654.0 70688.6 70809.3 70857.0 75257.0 75470.6 76275.6 76785.0 77125.0 17254.7 18502.8 18622.4 18772.6 18832.5 13041.3 13199.5 13230.2 13249.9 13272.5 21431.9 21553.0 21605.5 21663.5 21719.8 8040.7 8209.6 8223.5 8224.4 8461.5 1054.6 1144.2 1146.7 1202.2 1206.7 32753.8 33361.3 34164.0 34215.0 34351.5 1206.5 1215.2 1222.1 1294.5 1296.3 17372.0 17374.4 17483.2 17525.5 17911.6 501665.0 601081.0 606712.0 608354.0 610261.0 61799.0 62160.0 62516.0 62562.7 62600.7 1482.1 1495.7 1501.0 1506.5 1615.9 30198.5 31550.7 31829.0 31975.0 32710.3 46352.5 47069.0 47071.5 47097.5 47104.8 280779.0 286618.0 287061.0 287069.0 287576.0 27208.5 28369.4 30186.4 30455.7 30833.0 42768.6 42803.4 43010.8 43255.4 43955.6 35177.7 39233.0 40692.4 40810.2 41161.2 38638.4 39390.0 40012.4 40232.4 40498.6 40729.0 41548.2 41571.0 41611.8 41977.0 34463.7 35811.8 35828.1 36001.8 36434.3 27479.5 27936.3 27986.9 28087.6 28176.9 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#2] jquery.html Cycles:180 Average:32311.98 Median:11471.66 stddev:97262.90 (847.9%) stddev-sans-first:97506.28 16:10:21 INFO - PROCESS | 26891 | Values: 427.3 437.9 440.6 443.9 452.4 18757.5 18916.5 19526.7 20132.5 20145.5 19601.7 19702.6 20672.9 20858.7 20872.0 5696.2 5867.4 5931.9 6019.2 6027.7 4368.1 5867.1 5957.9 6107.3 6391.7 6332.6 6361.6 6373.6 6375.1 6379.1 5743.5 6012.2 6024.3 6026.0 6317.8 3942.3 5623.2 5851.6 5869.5 5897.7 14231.9 14360.9 14409.6 14484.6 23376.3 2484.8 2506.1 2517.5 2559.2 2657.9 10284.0 10290.6 10335.9 10794.8 10800.0 1978.7 2069.5 2090.4 2098.0 2125.4 79961.6 83558.6 83679.6 83728.6 85089.1 11278.6 11423.9 11467.7 11564.2 11658.7 15776.1 15908.9 15943.9 15945.9 16004.9 8524.1 8545.5 8565.5 8603.7 8641.7 8361.4 8382.5 8603.7 8689.7 9172.5 5071.6 5196.8 5200.3 5218.8 5255.1 1860.5 2008.4 2084.6 2089.6 2163.9 1018.7 1105.2 1134.2 1139.9 1203.5 17970.9 18261.5 18962.2 19323.7 19804.0 1041.7 1100.6 1101.6 1121.5 1134.6 10632.7 11018.8 11032.6 11130.4 11155.8 565945.0 566015.0 589019.0 615496.0 616949.0 101311.5 103501.0 106007.5 106018.5 106083.0 1156.2 1167.1 1180.6 1189.1 1192.6 16921.5 16995.3 17130.7 17302.4 17631.7 39092.0 39186.4 39954.0 40139.0 40497.4 60544.0 60832.4 61075.4 61323.0 61851.9 8770.9 8999.9 9065.9 9105.0 9138.5 10185.2 13869.4 14043.6 14111.9 14249.6 12275.8 12471.2 12570.2 12583.7 12684.0 11988.8 12139.2 12175.1 12367.2 12465.0 12321.3 12348.6 12578.8 12664.7 12818.5 8850.3 8866.8 8891.8 9022.3 9127.7 9256.0 12445.8 12572.5 12685.9 12903.6 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#3] mootools.html Cycles:180 Average:5893.53 Median:4820.52 stddev:3236.19 (67.1%) stddev-sans-first:3227.87 16:10:21 INFO - PROCESS | 26891 | Values: 1428.9 1588.8 1597.3 1796.7 1938.9 8415.6 8681.2 8681.7 8694.6 8705.0 8581.8 8772.0 8772.6 8776.4 8779.9 2159.9 2438.7 2484.0 2506.8 2514.0 2470.5 2491.1 2503.3 2503.5 2504.6 2424.9 2454.7 2456.0 2457.8 2459.0 2177.2 2419.6 2478.7 2480.1 2484.6 2304.9 2365.2 2365.8 2367.7 2368.8 8664.0 8701.5 8773.9 8775.3 8791.8 5196.4 5272.2 5294.9 5311.8 5376.7 3444.4 3520.7 3546.6 3549.4 3587.3 1140.8 1168.0 1171.8 1183.7 1215.2 11784.4 11823.6 11897.2 11905.0 11908.8 4787.8 4853.2 4854.0 4862.5 4908.4 10228.5 10242.1 10262.1 10264.3 10269.2 4869.9 5549.4 5552.4 5555.0 5557.5 5014.1 5024.5 5041.4 5081.3 5087.3 4253.5 4268.0 4277.8 4292.9 4321.3 1369.0 1392.5 1400.9 1416.1 1419.0 918.2 1084.8 1110.2 1117.3 1120.1 6299.3 6408.9 6416.2 6462.3 6474.1 515.0 518.2 1140.4 1156.3 1176.2 4145.3 4164.5 4168.6 4189.6 4192.5 10471.0 10926.1 10973.9 11044.3 11050.6 10826.6 10829.6 10837.1 10847.1 10848.7 8007.4 8211.7 8270.6 8365.6 8368.5 6115.7 6311.8 6313.1 6378.3 6430.2 9935.4 9991.8 10167.2 10216.0 10276.7 10189.6 10324.4 10329.2 10468.5 10574.9 7048.1 7500.4 7594.1 7757.6 7796.9 8663.7 8683.4 8704.7 8766.2 8776.7 7624.3 7743.7 7817.0 7859.3 7988.7 7622.5 7636.4 7727.2 7793.1 7819.0 7353.1 7355.4 7368.8 7402.6 7405.4 5263.3 5342.3 5407.5 5472.3 5510.4 5151.0 5163.1 5193.4 5354.2 5356.2 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#4] prototype.html Cycles:180 Average:5525.73 Median:6323.93 stddev:1658.03 (26.2%) stddev-sans-first:1616.42 16:10:21 INFO - PROCESS | 26891 | Values: 343.6 346.1 348.8 355.8 360.6 6290.4 6297.6 6306.3 6317.4 6338.8 5947.8 6130.7 6234.0 6238.8 6274.2 4709.1 4733.1 4733.3 4736.2 4754.1 4736.9 4738.1 4741.2 4762.8 4766.3 4544.5 4627.2 4666.7 4670.5 4780.6 4759.4 4768.0 4780.0 4790.5 4796.5 4208.5 4218.8 4220.2 4221.7 4223.0 5944.8 5991.5 5998.6 6000.4 6029.6 5554.3 5571.2 5577.9 5578.7 5586.7 6364.4 6571.4 6574.4 6583.6 6588.3 4626.4 4680.6 4693.2 4695.1 4702.2 6851.6 6860.0 6860.6 6865.5 6868.2 4799.2 4807.8 4808.4 4809.8 4812.2 4868.5 4871.6 4872.6 4872.9 4875.7 5288.4 5451.2 5489.0 5579.9 5582.7 6598.3 6634.4 6635.5 6641.7 6645.8 1640.9 1656.0 1660.7 1660.9 1661.8 1020.9 1078.1 1105.0 1105.9 1110.0 6321.6 6326.3 6345.7 6347.0 6418.1 6778.7 6783.7 6786.2 6793.7 6796.9 6411.2 6412.6 6413.7 6418.9 6428.1 3596.8 3644.5 3647.1 3674.7 3677.4 7035.9 7048.9 7061.0 7068.2 7074.2 6887.3 6895.6 6902.0 6914.3 6916.6 7054.9 7060.3 7063.9 7068.7 7069.6 6681.0 6791.7 6793.2 6800.5 6801.2 6570.9 6670.4 6673.4 6679.4 6684.1 7016.8 7033.5 7043.3 7045.8 7069.7 4663.7 4669.5 4669.8 4684.4 4687.4 6769.2 6788.9 6793.4 6795.7 6806.1 6433.7 6567.7 6579.7 6582.1 6589.5 6464.9 6530.3 6548.9 6565.1 6570.8 6470.0 6477.6 6483.3 6484.4 6487.7 6622.8 6638.1 6638.9 6642.0 6642.6 6180.1 6361.2 6475.7 6542.0 6542.5 16:10:21 INFO - PROCESS | 26891 | 16:10:21 INFO - PROCESS | 26891 | [#5] yui.html Cycles:180 Average:16079.29 Median:4157.29 stddev:18349.34 (441.4%) stddev-sans-first:18365.48 16:10:21 INFO - PROCESS | 26891 | Values: 914.7 925.5 938.1 940.1 964.0 14006.2 14189.4 14191.6 14240.3 14292.3 14534.9 14590.0 14590.2 14597.1 14620.3 753.6 768.3 770.2 770.3 899.9 913.9 915.3 915.9 916.6 924.2 970.4 970.4 970.9 971.3 972.7 954.0 955.2 957.5 959.7 959.9 580.6 681.3 690.7 710.5 714.7 14645.9 14662.8 14687.9 14697.3 14730.4 14013.7 14504.3 14673.7 14684.1 14765.2 11211.4 11294.5 11477.1 11531.8 11573.0 4068.3 4084.6 4151.1 4163.4 4169.7 54456.0 55386.0 55568.7 55849.7 56097.4 12088.5 12216.7 12297.0 12329.6 12403.9 21528.1 21559.6 21576.6 21583.0 21646.1 8785.7 8901.2 8904.3 9202.5 9282.3 4887.5 5022.1 5098.8 5141.9 5192.9 3554.4 3594.4 3596.7 3606.1 3606.4 708.1 710.0 716.8 725.0 728.3 684.7 751.4 761.1 767.9 773.1 9244.5 9893.4 10053.4 10205.3 10495.8 715.9 794.4 816.0 834.5 836.2 4547.2 4567.8 4583.3 4593.2 4728.6 60700.0 65997.3 66254.7 66934.3 67810.3 58018.0 58807.0 59404.7 59575.0 60218.4 52242.7 52310.7 53066.0 53707.0 55793.0 10165.6 10203.2 10229.8 10413.6 10418.4 40104.2 40612.0 40810.2 40835.4 41231.4 50036.7 50077.5 50824.2 53685.2 55008.0 13549.3 13569.4 13766.6 14462.7 14510.8 14167.1 14506.6 14706.2 14805.7 14837.9 13949.7 14208.7 14209.5 14609.7 14826.3 13721.9 14502.5 14844.0 14878.9 15194.8 14089.4 14102.1 14192.0 14398.5 14657.6 11240.0 11324.4 11747.1 11871.3 11878.2 11167.9 11566.4 11590.7 11964.6 12066.6 16:10:21 INFO - PROCESS | 26891 | -------- Summary: end -------- 16:10:21 INFO - PROCESS | 26891 | 16:10:22 INFO - TEST-INFO | 26891: exit 0 16:10:22 INFO - TEST-OK | dromaeo_css | took 1111080ms 16:10:22 INFO - TEST-START | kraken 16:10:22 INFO - operating with platform_type : linux_ 16:10:22 INFO - Initialising browser for kraken test... 16:10:22 INFO - TEST-INFO | started process 27079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGfOn2/profile http://localhost:56049/getInfo.html) 16:10:26 INFO - PROCESS | 27079 | __metrics Screen width/height:1600/1200 16:10:26 INFO - PROCESS | 27079 | colorDepth:24 16:10:26 INFO - PROCESS | 27079 | Browser inner width/height: 1024/697 16:10:26 INFO - PROCESS | 27079 | __metrics 16:10:27 ERROR - PROCESS | 27079 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:27 INFO - TEST-INFO | 27079: exit 0 16:10:27 INFO - Browser initialized. 16:10:27 INFO - Running cycle 1/1 for kraken test... 16:10:27 INFO - TEST-INFO | started process 27171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGfOn2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:39 INFO - PROCESS | 27171 | RSS: Main: 141975552 16:10:39 INFO - PROCESS | 27171 | 16:10:42 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:42 INFO - PROCESS | 27171 | RSS: Main: 197332992 16:10:42 INFO - PROCESS | 27171 | 16:10:45 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-dft) 16:10:46 INFO - PROCESS | 27171 | RSS: Main: 181407744 16:10:46 INFO - PROCESS | 27171 | 16:10:49 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-fft) 16:10:49 INFO - PROCESS | 27171 | RSS: Main: 272379904 16:10:49 INFO - PROCESS | 27171 | 16:10:51 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56049/tests/kraken/driver.html?testName=audio-oscillator) 16:10:52 INFO - PROCESS | 27171 | RSS: Main: 178515968 16:10:52 INFO - PROCESS | 27171 | 16:10:54 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:55 INFO - PROCESS | 27171 | RSS: Main: 177819648 16:10:55 INFO - PROCESS | 27171 | 16:10:58 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:58 INFO - PROCESS | 27171 | RSS: Main: 212393984 16:10:58 INFO - PROCESS | 27171 | 16:11:01 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56049/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:02 INFO - PROCESS | 27171 | RSS: Main: 212488192 16:11:02 INFO - PROCESS | 27171 | 16:11:05 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56049/tests/kraken/driver.html?testName=json-parse-financial) 16:11:05 INFO - PROCESS | 27171 | RSS: Main: 211779584 16:11:05 INFO - PROCESS | 27171 | 16:11:07 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:08 INFO - PROCESS | 27171 | RSS: Main: 189890560 16:11:08 INFO - PROCESS | 27171 | 16:11:09 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:10 INFO - PROCESS | 27171 | RSS: Main: 192573440 16:11:10 INFO - PROCESS | 27171 | 16:11:12 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:12 INFO - PROCESS | 27171 | RSS: Main: 206426112 16:11:12 INFO - PROCESS | 27171 | 16:11:15 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:15 INFO - PROCESS | 27171 | RSS: Main: 213995520 16:11:15 INFO - PROCESS | 27171 | 16:11:18 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:19 INFO - PROCESS | 27171 | RSS: Main: 210067456 16:11:19 INFO - PROCESS | 27171 | 16:11:20 INFO - PROCESS | 27171 | Cycle 1(1): loaded http://localhost:56049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56049/tests/kraken/driver.html?testName=ai-astar) 16:11:21 INFO - PROCESS | 27171 | RSS: Main: 274325504 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | __start_tp_report 16:11:21 INFO - PROCESS | 27171 | _x_x_mozilla_page_load 16:11:21 INFO - PROCESS | 27171 | _x_x_mozilla_page_load_details 16:11:21 INFO - PROCESS | 27171 | |i|pagename|runs| 16:11:21 INFO - PROCESS | 27171 | |0;ai-astar;111;113;112;109;111;112;105;111;110;109 16:11:21 INFO - PROCESS | 27171 | |1;audio-beat-detection;151;130;152;180;126;150;159;126;187;125 16:11:21 INFO - PROCESS | 27171 | |2;audio-dft;162;163;161;163;161;161;164;161;161;160 16:11:21 INFO - PROCESS | 27171 | |3;audio-fft;76;76;77;166;75;76;74;73;160;75 16:11:21 INFO - PROCESS | 27171 | |4;audio-oscillator;93;93;154;92;92;92;140;93;93;154 16:11:21 INFO - PROCESS | 27171 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;116;117;117 16:11:21 INFO - PROCESS | 27171 | |6;imaging-darkroom;146;145;145;146;145;145;145;145;145;145 16:11:21 INFO - PROCESS | 27171 | |7;imaging-desaturate;94;95;94;95;95;94;95;94;95;94 16:11:21 INFO - PROCESS | 27171 | |8;json-parse-financial;53;57;52;53;54;54;53;74;51;52 16:11:21 INFO - PROCESS | 27171 | |9;json-stringify-tinderbox;58;57;57;57;57;57;58;57;56;59 16:11:21 INFO - PROCESS | 27171 | |10;stanford-crypto-aes;73;74;73;75;73;74;74;74;74;80 16:11:21 INFO - PROCESS | 27171 | |11;stanford-crypto-ccm;117;115;117;113;110;113;112;119;143;130 16:11:21 INFO - PROCESS | 27171 | |12;stanford-crypto-pbkdf2;162;158;160;157;156;158;158;165;153;159 16:11:21 INFO - PROCESS | 27171 | |13;stanford-crypto-sha256-iterative;66;66;65;66;64;65;65;64;64;65 16:11:21 INFO - PROCESS | 27171 | __end_tp_report 16:11:21 INFO - PROCESS | 27171 | __start_cc_report 16:11:21 INFO - PROCESS | 27171 | _x_x_mozilla_cycle_collect,1589 16:11:21 INFO - PROCESS | 27171 | __end_cc_report 16:11:21 INFO - PROCESS | 27171 | __startTimestamp1464649881085__endTimestamp 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | ------- Summary: start ------- 16:11:21 INFO - PROCESS | 27171 | Number of tests: 14 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.39 16:11:21 INFO - PROCESS | 27171 | Values: 111.0 113.0 112.0 109.0 111.0 112.0 105.0 111.0 110.0 109.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:151.50 stddev:22.39 (14.8%) stddev-sans-first:23.73 16:11:21 INFO - PROCESS | 27171 | Values: 151.0 130.0 152.0 180.0 126.0 150.0 159.0 126.0 187.0 125.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 16:11:21 INFO - PROCESS | 27171 | Values: 162.0 163.0 161.0 163.0 161.0 161.0 164.0 161.0 161.0 160.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:37.04 (49.1%) stddev-sans-first:38.79 16:11:21 INFO - PROCESS | 27171 | Values: 76.0 76.0 77.0 166.0 75.0 76.0 74.0 73.0 160.0 75.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.50 stddev:27.69 (29.9%) stddev-sans-first:28.71 16:11:21 INFO - PROCESS | 27171 | Values: 93.0 93.0 154.0 92.0 92.0 92.0 140.0 93.0 93.0 154.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:11:21 INFO - PROCESS | 27171 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 16:11:21 INFO - PROCESS | 27171 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:11:21 INFO - PROCESS | 27171 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:53.50 stddev:6.77 (12.6%) stddev-sans-first:7.13 16:11:21 INFO - PROCESS | 27171 | Values: 53.0 57.0 52.0 53.0 54.0 54.0 53.0 74.0 51.0 52.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 16:11:21 INFO - PROCESS | 27171 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 58.0 57.0 56.0 59.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.07 (2.8%) stddev-sans-first:2.13 16:11:21 INFO - PROCESS | 27171 | Values: 73.0 74.0 73.0 75.0 73.0 74.0 74.0 74.0 74.0 80.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.00 stddev:10.13 (8.7%) stddev-sans-first:10.72 16:11:21 INFO - PROCESS | 27171 | Values: 117.0 115.0 117.0 113.0 110.0 113.0 112.0 119.0 143.0 130.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.50 stddev:3.27 (2.1%) stddev-sans-first:3.23 16:11:21 INFO - PROCESS | 27171 | Values: 162.0 158.0 160.0 157.0 156.0 158.0 158.0 165.0 153.0 159.0 16:11:21 INFO - PROCESS | 27171 | 16:11:21 INFO - PROCESS | 27171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 16:11:21 INFO - PROCESS | 27171 | Values: 66.0 66.0 65.0 66.0 64.0 65.0 65.0 64.0 64.0 65.0 16:11:21 INFO - PROCESS | 27171 | -------- Summary: end -------- 16:11:21 INFO - PROCESS | 27171 | 16:11:22 INFO - TEST-INFO | 27171: exit 0 16:11:22 INFO - TEST-OK | kraken | took 59856ms 16:11:22 INFO - SUITE-END | took 1170s 16:11:22 INFO - Completed test suite (00:19:31) 16:11:22 INFO - javascript benchmark 16:11:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.4851697986815, 3364.226227967569, 3373.055544447554, 3395.2021275000384, 3401.7958922464654, 5593.692346920918, 5624.015797235483, 5646.971765141178, 5668.43315668434, 5686.402927692595, 5632.07070833312, 5684.488396044355, 5685.260916080903, 5691.203231547586, 5693.8576535586635, 4927.556519913207, 5131.153359695655, 5201.635885488017, 5265.973670131663, 5284.44513326101, 5127.9230811537855, 5165.276861239429, 5165.896682066356, 5172.09488339541, 5173.637845350827, 5081.060003899272, 5088.669236499634, 5158.638895277313, 5166.974165129169, 5178.5339319461245, 5155.3040339554245, 5173.9741301293625, 5180.481951804846, 5181.585473162176, 5215.765290561933, 4919.11455937931, 5001.624878134155, 5025.949740502585, 5078.6698864574055, 5095.923561146586, 5414.160805075219, 5463.754131064112, 5475.7262136893, 5499.0, 5507.146392309199, 5978.8505287367725, 5997.100434934751, 6005.699715014275, 6011.819645410645, 6015.428534289235, 6028.788992385289, 6053.122297266916, 6117.583823141527, 6133.1106989486725, 6135.570510064297, 5640.0693885508845, 5678.290213723285, 5679.943200567983, 5683.687397193153, 5686.3744988051285, 6056.818295451144, 6189.0, 6194.0708893665405, 6205.286392064971, 6208.099825525273, 5912.054071348563, 5952.940470595238, 5968.731407086691, 5977.910331345033, 5984.461398474158, 6017.669028203403, 6030.698465076729, 6037.335893051761, 6039.184710064173, 6047.546434017467, 5836.678982655994, 5918.496927761103, 5978.730957106941, 5988.401159884064, 5988.431099045583, 5906.911396329058, 5911.024680927685, 5911.467967882825, 5914.704264786744, 5951.077582974646, 4512.548745125461, 4513.11994161142, 4519.593236608721, 4529.5243999380245, 4549.249373853343, 4040.252553277653, 4044.0, 4056.5334986476932, 4081.734687245379, 4103.4050062741335, 5730.570207234474, 5754.6547207167705, 5758.539316854642, 5760.251167348218, 5779.595428319977, 5993.250843644544, 6046.606970546901, 6048.274207095089, 6050.57645964787, 6052.515798736091, 5654.06707893193, 5689.402612725687, 5701.173329867146, 5729.627574207663, 5751.798687045934, 5119.897602047939, 5126.743662816844, 5128.205128205134, 5129.230615407719, 5131.0, 6178.351273116348, 6178.69106544671, 6179.16581261533, 6182.938170618326, 6183.134361189437, 5900.64596124234, 5957.046872500552, 6022.3977602241175, 6029.246344206974, 6042.637441753509, 6201.906971395523, 6202.472789812917, 6205.503559715302, 6225.408586184305, 6228.065790131516, 5790.305163380422, 5894.557908156819, 5902.203202567598, 5916.852078698067, 5943.851403714942, 5943.346231914399, 5994.790182343597, 6006.09908513709, 6007.639541627516, 6029.216201893902, 5800.50695690871, 5845.649261044351, 5847.912281315868, 5850.297964244318, 5855.2973643163095, 5747.4252574742195, 5760.884782304414, 5807.883842323045, 5830.883382332415, 5843.474087332161, 5687.402822703557, 5688.971555142198, 5689.658620482619, 5703.030484817674, 5719.342275638189, 5781.219535362672, 5784.8553786154, 5785.971070144622, 5811.186433899342, 5823.94176058234, 5658.094704847204, 5678.517326027334, 5696.743646535833, 5739.62692424991, 5746.712664366682], "value": 5533.528970343619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.6598018000909, 674.2852576269158, 687.529042605815, 745.0649434959125, 756.9402836029561, 40655.0, 41363.79318103405, 41537.99999999996, 41564.37653435193, 41573.58426415735, 44053.11893762131, 44881.0, 44882.77558612211, 44922.326165107464, 44984.3252351215, 8018.438709290352, 8787.384883058172, 8977.057408972061, 10400.687979360631, 10609.522571484302, 10342.482875856214, 10460.686179414592, 10469.16246700266, 10469.371837689725, 10473.633422830202, 10458.947705261464, 10506.947465262663, 10526.157907367393, 10541.578336866516, 10544.367337959748, 8227.300679442254, 10440.112590429784, 10606.310589811637, 10611.522481488351, 10621.25651204416, 10566.471676416148, 10685.679429617125, 10687.358758474516, 10688.572457101707, 10693.358398496037, 41714.58285417168, 42193.36709949353, 42214.577854221374, 42262.0, 42335.57664423347, 3730.7015438764834, 3837.194189220267, 4073.5722749111214, 4167.374893765929, 4364.781760911974, 34726.305473890636, 35511.82244088789, 35577.28845423077, 35711.82144089289, 35779.64220357815, 4634.688832856947, 4651.879848816385, 4654.394928659286, 4673.532646735333, 4765.428148622187, 339973.0, 343259.0, 345788.0, 346230.0, 346678.0, 69683.65158174177, 70654.0, 70688.6465567669, 70809.2919070813, 70857.0, 75257.0, 75470.62264688751, 76275.61862190765, 76785.0, 77125.0, 17254.741178882326, 18502.814971850108, 18622.441326760218, 18772.624547508975, 18832.529186770167, 13041.347932603332, 13199.53801616958, 13230.206187628773, 13249.933750331187, 13272.535461258809, 21431.89284053601, 21553.0, 21605.45986350354, 21663.458413539473, 21719.782802171776, 8040.67837286502, 8209.58952052395, 8223.54770487629, 8224.38317126218, 8461.534615596078, 1054.5518154784186, 1144.2219290882113, 1146.696125526736, 1202.2005366431226, 1206.6983254186453, 32753.78967609829, 33361.332773344395, 34164.0, 34215.0, 34351.484727729105, 1206.5234232478122, 1215.1554669504785, 1222.0895432902544, 1294.527497463419, 1296.3453456004845, 17372.0, 17374.39189628357, 17483.213255403538, 17525.47423577295, 17911.552211194823, 501665.0, 601081.0, 606712.0, 608354.0, 610261.0, 61799.0, 62160.0, 62516.0, 62562.68718656377, 62600.68699656473, 1482.1255459278862, 1495.6634757179547, 1500.9943337963591, 1506.4501456968346, 1615.8949668271525, 30198.54702179513, 31550.684493154775, 31829.0, 31975.0, 32710.34579308448, 46352.53647463482, 47069.0, 47071.52928470672, 47097.529024709314, 47104.764476178774, 280779.0, 286618.0, 287061.0, 287069.0, 287576.0, 27208.455830883668, 28369.43261134807, 30186.396272073995, 30455.695443045286, 30833.0, 42768.572314277706, 42803.357949631405, 43010.784946075066, 43255.351169731846, 43955.560444396426, 35177.714594777026, 39233.0, 40692.38961415522, 40810.1837963245, 41161.176776464905, 38638.42042369423, 39390.0, 40012.399814003395, 40232.396514051725, 40498.59501404948, 40729.0, 41548.1690366197, 41571.0, 41611.7919410401, 41977.0, 34463.65536344604, 35811.82094089617, 35828.104297392776, 36001.81999089988, 36434.27131457409, 27479.450410992067, 27936.30159246035, 27986.8920386067, 28087.578686320132, 28176.85911570429], "value": 21178.46152143624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.2501759412232, 437.9408779814724, 440.596853878701, 443.9489458712247, 452.4299382777699, 18757.531061723446, 18916.527086822836, 19526.70709939352, 20132.49668758278, 20145.496362590944, 19601.705974410394, 19702.605947881035, 20672.8966355168, 20858.68711969318, 20872.0, 5696.1740547620675, 5867.413258674141, 5931.940680593182, 6019.187409699678, 6027.698615069251, 4368.060866913613, 5867.061270196769, 5957.940420595782, 6107.26712794463, 6391.744330226786, 6332.588381755171, 6361.6183029018175, 6373.617582945015, 6375.10748495211, 6379.07503412005, 5743.5118014968775, 6012.218411606507, 6024.277086749575, 6026.035834266497, 6317.842053948642, 3942.2706799242233, 5623.240862483594, 5851.64890106595, 5869.50109240715, 5897.675627840467, 14231.857681423156, 14360.928195359062, 14409.639759006108, 14484.565463036126, 23376.298711038697, 2484.7887929526014, 2506.1103308325464, 2517.4713310204697, 2559.1554786920274, 2657.946841063187, 10284.0, 10290.639827605997, 10335.896641033569, 10794.78410431787, 10800.027997480185, 1978.703194520819, 2069.513664288906, 2090.3833369156137, 2098.0, 2125.3517677108475, 79961.60019199867, 83558.58220708858, 83679.5816020922, 83728.58135709344, 85089.14910850875, 11278.605248816251, 11423.942880285545, 11467.655970320904, 11564.190506664452, 11658.6502404928, 15776.13231272268, 15908.92045539788, 15943.920280398524, 15945.920270398574, 16004.91997540005, 8524.147585241426, 8545.487270763773, 8565.528895910784, 8603.741887743377, 8641.654333826702, 8361.372897032747, 8382.49705017701, 8603.655853765778, 8689.695860644848, 9172.495512746864, 5071.619628527801, 5196.76614552346, 5200.349956255468, 5218.843434696965, 5255.106631872591, 1860.451166905766, 2008.3974807557674, 2084.6247675418267, 2089.613421517024, 2163.8701677899376, 1018.6689325969089, 1105.160078340451, 1134.1777211521746, 1139.880312567185, 1203.524607779922, 17970.91014544919, 18261.54346141357, 18962.24151033943, 19323.710144347846, 19804.0, 1041.7031146123318, 1100.6147848253047, 1101.5979167603766, 1121.4897221764077, 1134.6028889888637, 10632.734181645521, 11018.779624407467, 11032.558697652164, 11130.443477826077, 11155.832662510069, 565945.0, 566015.0, 589019.0, 615496.0, 616949.0, 101311.49344253232, 103501.0, 106007.46996265123, 106018.46990765151, 106083.0, 1156.2022204678744, 1167.101331974392, 1180.5513904716324, 1189.0903458853984, 1192.648168790209, 16921.492355229362, 16995.32018719287, 17130.657386852443, 17302.394416195373, 17631.735523967407, 39092.0, 39186.412203817534, 39954.0, 40139.0, 40497.392539111344, 60544.0, 60832.391676082676, 61075.389246108745, 61323.0, 61851.909074144205, 8770.868436973324, 8999.910000899907, 9065.864012039692, 9105.0, 9138.451692898447, 10185.236107291834, 13869.445222191, 14043.648908777363, 14111.858881411055, 14249.572512824632, 12275.754484910072, 12471.189372690746, 12570.245785252913, 12583.748325033632, 12684.0, 11988.76022479563, 12139.21095128849, 12175.14773965814, 12367.196132251374, 12465.0, 12321.322327271728, 12348.567800126952, 12578.811317830423, 12664.74670506603, 12818.487260509475, 8850.291976641982, 8866.778330541789, 8891.822163556822, 9022.278217742434, 9127.680531181642, 9256.028117047614, 12445.75108497843, 12572.497100115894, 12685.873141268468, 12903.612891613267], "value": 9626.668453213322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.9214093224869, 1588.7537431698088, 1597.3051722500709, 1796.7035439152542, 1938.8933608651528, 8415.621297041633, 8681.175288347597, 8681.696140635078, 8694.56527173642, 8704.956475217623, 8581.828363432727, 8771.956140219307, 8772.649094036231, 8776.385653004292, 8779.912200877989, 2159.8920053997317, 2438.6829712137487, 2483.987580062097, 2506.774390304872, 2514.0446630280467, 2470.4564995701007, 2491.115653942851, 2503.2740505253455, 2503.5368456835545, 2504.611785173292, 2424.866632335221, 2454.7054353477606, 2455.9631605525933, 2457.778799908008, 2458.9877050614723, 2177.1944380579207, 2419.63705444183, 2478.6901637295337, 2480.119557557068, 2484.565201089802, 2304.9078036878673, 2365.2431222008963, 2365.8343915925893, 2367.6922000140044, 2368.7749663781915, 8664.0, 8701.47791132534, 8773.868391974125, 8775.341849361323, 8791.78020549485, 5196.402413722395, 5272.235525848769, 5294.894102117936, 5311.760970756325, 5376.704281264529, 3444.362792883325, 3520.7359448041243, 3546.6453354664586, 3549.4498352755363, 3587.3004764071015, 1140.766142940695, 1167.9824802627968, 1171.8476598042284, 1183.6922400175931, 1215.228330010441, 11784.351860647661, 11823.645290641294, 11897.167198296123, 11905.0, 11908.821367679491, 4787.832425865147, 4853.19922212838, 4853.95146048542, 4862.489438608895, 4908.3619129513645, 10228.488575571191, 10242.129418999319, 10262.127719143808, 10264.332818366931, 10269.178465722724, 4869.853904382874, 5549.445055494499, 5552.3892371839065, 5555.0, 5557.472040156179, 5014.07239660664, 5024.497550244946, 5041.445441001487, 5081.263216833612, 5087.262346959744, 4253.468316460442, 4267.95435118398, 4277.8288868444915, 4292.8838501989085, 4321.308590625485, 1368.9520866769615, 1392.5195807446414, 1400.9019368644301, 1416.129080615414, 1418.9929050354683, 918.1874041473344, 1084.7938891610568, 1110.1784679337393, 1117.2626066795876, 1120.0871289898869, 6299.275583307886, 6408.903866442007, 6416.165898433173, 6462.32145624712, 6474.093626892239, 515.0445922813202, 518.2045560065282, 1140.4183866228284, 1156.306216270231, 1176.211938001541, 4145.316022856195, 4164.5210800757695, 4168.645665118499, 4189.6229339359, 4192.4759405074365, 10471.0, 10926.125909927347, 10973.945130274298, 11044.282121662067, 11050.557977680963, 10826.62106826273, 10829.620963266249, 10837.133029357632, 10847.077998370227, 10848.67453976382, 8007.359411247203, 8211.71259005932, 8270.627821748036, 8365.58172091393, 8368.539730314891, 6115.663638499926, 6311.846232365788, 6313.147725057059, 6378.266499352449, 6430.164078669743, 9935.403875767477, 9991.750206244611, 10167.237457190593, 10216.0, 10276.691699249035, 10189.643362482277, 10324.380537167794, 10329.225308102074, 10468.528916198637, 10574.947125264325, 7048.118985126859, 7500.437467189873, 7594.126675432396, 7757.573333466487, 7796.922030779847, 8663.653453862027, 8683.392162548562, 8704.651813927372, 8766.211041006085, 8776.692815751418, 7624.313811756969, 7743.683573792357, 7816.960915195387, 7859.253370929752, 7988.720394786154, 7622.5426474411715, 7636.350910172698, 7727.150013498398, 7793.10379306387, 7819.0, 7353.117625884928, 7355.411567074514, 7368.778936631909, 7402.592857392679, 7405.44459165554, 5263.289455923555, 5342.332208473941, 5407.540359069366, 5472.261244731911, 5510.366307874646, 5151.0470562945975, 5163.122269214167, 5193.37679478465, 5354.223637572608, 5356.223347614497], "value": 4771.939274877433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.560242889102, 346.0949616752194, 348.7698119241301, 355.765194971319, 360.59072952199256, 6290.433860952513, 6297.590656607323, 6306.274778400485, 6317.431431171193, 6338.778142765004, 5947.821565353035, 6130.693465326727, 6234.033724772657, 6238.812835614927, 6274.184356033721, 4709.105269998689, 4733.053389322132, 4733.313669517918, 4736.218523943562, 4754.072955773626, 4736.928946065795, 4738.099761045408, 4741.170295198343, 4762.809487620509, 4766.285057241407, 4544.477385100723, 4627.190241707704, 4666.719996800186, 4670.509596492353, 4780.617550595944, 4759.40507436567, 4768.022555376174, 4779.996200797819, 4790.496997815214, 4796.544328288807, 4208.473940757405, 4218.831246750157, 4220.155968806251, 4221.7255878367805, 4222.9788851055855, 5944.762209511614, 5991.490723288525, 5998.550108741862, 6000.36996115406, 6029.60807547508, 5554.250176226198, 5571.164325351189, 5577.944220557783, 5578.693171875586, 5586.720663966786, 6364.395382438661, 6571.44142747867, 6574.3754343337305, 6583.572067815625, 6588.341165883373, 4626.421697287839, 4680.555347242007, 4693.178693728584, 4695.060987802453, 4702.224133018048, 6851.623160726158, 6859.965700171517, 6860.554063985775, 6865.485088618374, 6868.244493105754, 4799.160146974265, 4807.831725889577, 4808.35087263222, 4809.759512024385, 4812.1578723723205, 4868.488808675109, 4871.610271178297, 4872.585830204473, 4872.927955849707, 4875.7074575525585, 5288.391834938954, 5451.209574611738, 5489.039418101816, 5579.860503487364, 5582.665040097526, 6598.274189839114, 6634.402903738686, 6635.469162466991, 6641.66791660415, 6645.833854153588, 1640.9343626255054, 1655.983440165607, 1660.6512632347342, 1660.9169541522876, 1661.825508321633, 1020.8877023527406, 1078.1374900080061, 1104.9613263535737, 1105.8728246251785, 1110.0342701849281, 6321.589096708699, 6326.272478665012, 6345.650989195547, 6347.047942808524, 6418.133551970518, 6778.72885084601, 6783.694733736994, 6786.151731033621, 6793.728250870009, 6796.932030679729, 6411.198600174978, 6412.64730439821, 6413.711382987777, 6418.935810641834, 6428.132202152649, 3596.8381422836037, 3644.5079914211774, 3647.0517665406655, 3674.706023518112, 3677.3564626190846, 7035.894461583081, 7048.859022819617, 7061.046758687614, 7068.151821781419, 7074.186468556182, 6887.345702158287, 6895.55178913369, 6901.965490172517, 6914.274001229798, 6916.619585922722, 7054.894176587355, 7060.258672839381, 7063.940408938597, 7068.68190931399, 7069.611171385521, 6681.0, 6791.72833086671, 6793.218779840382, 6800.52396332252, 6801.18385793708, 6570.901436478553, 6670.39966403026, 6673.432758215606, 6679.365460281266, 6684.06423100776, 7016.789496315118, 7033.542819716907, 7043.2604576518725, 7045.753398631024, 7069.71721131149, 4663.720176789404, 4669.509701481295, 4669.7898594564, 4684.414448193976, 4687.367205427224, 6769.221539523018, 6788.898166527407, 6793.354631310215, 6795.694193761194, 6806.115205023513, 6433.742650293936, 6567.704453299518, 6579.671016449254, 6582.078509008838, 6589.47284217271, 6464.935350646433, 6530.314316996837, 6548.901766473602, 6565.080888675494, 6570.77002304917, 6470.0, 6477.643729594917, 6483.2544257411, 6484.383983521558, 6487.675616219264, 6622.768203112868, 6638.070670106285, 6638.933610664025, 6642.036904648896, 6642.568233064835, 6180.134781130555, 6361.2048493938255, 6475.708593113415, 6542.018697195459, 6542.476601871934], "value": 4982.29218333239, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.6752902719533, 925.4632313258311, 938.118168921214, 940.1022023967112, 963.9903600963993, 14006.22965736884, 14189.361478733455, 14191.645208869784, 14240.287985600717, 14292.285385730711, 14534.854651453483, 14590.0, 14590.197539135343, 14597.051191672534, 14620.34208460619, 753.6344872736719, 768.2931702833407, 770.2028400605375, 770.3144201660526, 899.9145081217307, 913.853783394657, 915.3455279475174, 915.8946721127089, 916.5508900638706, 924.154398725169, 970.3595626886256, 970.403202030753, 970.9368891022061, 971.2909576009517, 972.7373609125532, 954.0459540459541, 955.2167222877243, 957.5355952363099, 959.7264779537799, 959.8608201810733, 580.5703779203401, 681.325487767107, 690.730615060127, 710.5026481462996, 714.6712512244374, 14645.853541464661, 14662.780058299135, 14687.853121468755, 14697.33861976203, 14730.410783568645, 14013.719725605533, 14504.347304371224, 14673.706525869422, 14684.118952862862, 14765.18791466469, 11211.439428028647, 11294.491747871365, 11477.139214558942, 11531.827022594667, 11572.95843374092, 4068.3490641497515, 4084.611961863618, 4151.14901445206, 4163.437935878648, 4169.749815011109, 54456.0, 55386.0, 55568.72215638936, 55849.72075139639, 56097.43902560963, 12088.516459341703, 12216.694582635506, 12297.0, 12329.568465103857, 12403.875961240452, 21528.13887444516, 21559.56880862405, 21576.56846863054, 21583.0, 21646.134154633954, 8785.736427907173, 8901.154390332907, 8904.332175086894, 9202.539873006323, 9282.30382721285, 4887.511248875155, 5022.121128802445, 5098.821541246039, 5141.897162056738, 5192.92210616841, 3554.413521768879, 3594.353016457063, 3596.7302452315657, 3606.098475381155, 3606.386914224588, 708.0971761004657, 709.975150869717, 716.802879208222, 724.9927500724925, 728.2717282717283, 684.6610927590874, 751.4101430377127, 761.1437133225122, 767.9232076792276, 773.1495355109447, 9244.491552964651, 9893.406395616286, 10053.396796192252, 10205.285630005828, 10495.842562361571, 715.860407220587, 794.3639875086254, 816.0, 834.4826207751233, 836.1638361638362, 4547.1815073287125, 4567.771611419415, 4583.335416364608, 4593.150267200579, 4728.598069164091, 60700.0, 65997.34002659912, 66254.66872665606, 66934.33065669281, 67810.32189678139, 58018.0, 58807.0, 59404.70297648484, 59575.0, 60218.39781602215, 52242.738786305825, 52310.73844630752, 53066.0, 53707.0, 55792.999999999185, 10165.593376264867, 10203.150871000531, 10229.84655230187, 10413.57686756588, 10418.426986515511, 40104.197916042096, 40612.0, 40810.1837963245, 40835.38746918858, 41231.381529276485, 50036.74981625069, 50077.49922500728, 50824.237636434744, 53685.194722079985, 55008.0, 13549.254790986197, 13569.389377477839, 13766.587002389944, 14462.710745785236, 14510.782338264724, 14167.149971001772, 14506.637334066732, 14706.191159485903, 14805.703885922007, 14837.851621484078, 13949.721005579628, 14208.715825683636, 14209.50266740659, 14609.707805843611, 14826.332815023565, 13721.931390342985, 14502.492412765503, 14844.0, 14878.925605371904, 15194.848051519344, 14089.365978531196, 14102.083364581269, 14192.0, 14398.496052638526, 14657.56027319182, 11240.0, 11324.37715925632, 11747.118966077407, 11871.347075910908, 11878.168528202943, 11167.88832111701, 11566.421678915853, 11590.71023224426, 11964.58123965657, 12066.577669781516], "value": 7357.526899293669, "unit": "score"}], "name": "dromaeo_css", "value": 7630.354727821384, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 109.0, 111.0, 112.0, 105.0, 111.0, 110.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 152.0, 180.0, 126.0, 150.0, 159.0, 126.0, 187.0, 125.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 161.0, 161.0, 164.0, 161.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 166.0, 75.0, 76.0, 74.0, 73.0, 160.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 92.0, 92.0, 92.0, 140.0, 93.0, 93.0, 154.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 52.0, 53.0, 54.0, 54.0, 53.0, 74.0, 51.0, 52.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 56.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 75.0, 73.0, 74.0, 74.0, 74.0, 74.0, 80.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 117.0, 113.0, 110.0, 113.0, 112.0, 119.0, 143.0, 130.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 160.0, 157.0, 156.0, 158.0, 158.0, 165.0, 153.0, 159.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1509.1, "alertThreshold": 2.0}]} 16:11:22 INFO - Return code: 0 16:11:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:22 ERROR - # TBPL SUCCESS # 16:11:22 INFO - Running post-action listener: _resource_record_post_action 16:11:22 INFO - Running post-run listener: _resource_record_post_run 16:11:23 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 500953088; Read time: 0; Write time: 405872 16:11:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249266176; Read time: 0; Write time: 246688 16:11:23 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 251686912; Read time: 0; Write time: 159184 16:11:23 INFO - Running post-run listener: _upload_blobber_files 16:11:23 INFO - Blob upload gear active. 16:11:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:23 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 16:11:23 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'] 16:11:23 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 16:11:23 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:24 INFO - (blobuploader) - INFO - Done attempting. 16:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:25 INFO - (blobuploader) - INFO - Done attempting. 16:11:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:25 INFO - Return code: 0 16:11:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a9398e4db6aad6a99fedd244a0e6bd752b097b474aeeb8431ad8e7097083b12ed3059be481d69cdd6fa0aef251a25219a0e97b7ee86769106cbea1b87d3577d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} 16:11:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:25 INFO - Contents: 16:11:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a9398e4db6aad6a99fedd244a0e6bd752b097b474aeeb8431ad8e7097083b12ed3059be481d69cdd6fa0aef251a25219a0e97b7ee86769106cbea1b87d3577d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} 16:11:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:25 INFO - Copying logs to upload dir... 16:11:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.787737 ========= master_lag: 1.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-30 16:11:26.823667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-05-30 16:11:26.825886) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 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/4a9398e4db6aad6a99fedd244a0e6bd752b097b474aeeb8431ad8e7097083b12ed3059be481d69cdd6fa0aef251a25219a0e97b7ee86769106cbea1b87d3577d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/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/4a9398e4db6aad6a99fedd244a0e6bd752b097b474aeeb8431ad8e7097083b12ed3059be481d69cdd6fa0aef251a25219a0e97b7ee86769106cbea1b87d3577d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae839ec8ecf44a44510df48a5b50dd9841342b64c99062384e4ee25cb3fd8127a650d3c3036d11eaca426883beae1967f0146b951e1b96a70953f9c330f057ee"}' ========= master_lag: 3.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-05-30 16:11:30.179627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:30.180050) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464648207.55620-1555054468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:11:30.205597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:30.205914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:11:30.206186) ========= ========= Total master_lag: 4.91 =========