builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1462585470.51 results: success (0) buildid: 20160506160946 builduid: 209459d8cf2747b3b591f0d202dc4a09 revision: 0f66fd75014070ca82ddb8867bb85152d3d42484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.515173) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.516549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.516855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.532939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.533220) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 18:44:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-06 18:44:30 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.681416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.681732) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.733902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 18:44:30.734232) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f66fd75014070ca82ddb8867bb85152d3d42484 --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 0f66fd75014070ca82ddb8867bb85152d3d42484 --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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 18:44:30,817 truncating revision to first 12 chars 2016-05-06 18:44:30,817 Setting DEBUG logging. 2016-05-06 18:44:30,817 attempt 1/10 2016-05-06 18:44:30,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f66fd750140?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 18:44:31,988 unpacking tar archive at: mozilla-aurora-0f66fd750140/testing/mozharness/ program finished with exit code 0 elapsedTime=1.427243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 18:44:32.176925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:32.177219) ========= script_repo_revision: 0f66fd75014070ca82ddb8867bb85152d3d42484 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:32.178539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:32.178813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:32.188644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-06 18:44:32.188911) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:32 INFO - MultiFileLogger online at 20160506 18:44:32 in /builds/slave/test 18:44:32 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 18:44:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:32 INFO - {'append_to_log': False, 18:44:32 INFO - 'base_work_dir': '/builds/slave/test', 18:44:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:44:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:32 INFO - 'branch': 'Mozilla-Aurora', 18:44:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:32 INFO - 'config_files': ('talos/linux_config.py',), 18:44:32 INFO - 'default_actions': ('clobber', 18:44:32 INFO - 'read-buildbot-config', 18:44:32 INFO - 'download-and-extract', 18:44:32 INFO - 'populate-webroot', 18:44:32 INFO - 'create-virtualenv', 18:44:32 INFO - 'install', 18:44:32 INFO - 'run-tests'), 18:44:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:32 INFO - 'download_minidump_stackwalk': True, 18:44:32 INFO - 'download_symbols': 'ondemand', 18:44:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:32 INFO - 'installer_path': 'installer.exe', 18:44:32 INFO - 'log_level': 'info', 18:44:32 INFO - 'log_name': 'talos', 18:44:32 INFO - 'log_to_console': True, 18:44:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:32 INFO - 'opt_config_files': (), 18:44:32 INFO - 'pip_index': False, 18:44:32 INFO - 'sps_profile': False, 18:44:32 INFO - 'sps_profile_interval': 0, 18:44:32 INFO - 'suite': 'dromaeojs', 18:44:32 INFO - 'system_bits': '32', 18:44:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:32 INFO - 'title': 'talos-linux64-ix-057', 18:44:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:32 INFO - 'use_talos_json': True, 18:44:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:32 INFO - 'work_dir': 'build'} 18:44:32 INFO - ##### 18:44:32 INFO - ##### Running clobber step. 18:44:32 INFO - ##### 18:44:32 INFO - Running pre-action listener: _resource_record_pre_action 18:44:32 INFO - Running main action method: clobber 18:44:32 INFO - rmtree: /builds/slave/test/build 18:44:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:33 INFO - Running post-action listener: _resource_record_post_action 18:44:33 INFO - ##### 18:44:33 INFO - ##### Running read-buildbot-config step. 18:44:33 INFO - ##### 18:44:33 INFO - Running pre-action listener: _resource_record_pre_action 18:44:33 INFO - Running main action method: read_buildbot_config 18:44:33 INFO - Using buildbot properties: 18:44:33 INFO - { 18:44:33 INFO - "project": "", 18:44:33 INFO - "product": "firefox", 18:44:33 INFO - "script_repo_revision": "production", 18:44:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:44:33 INFO - "repository": "", 18:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:44:33 INFO - "buildid": "20160506160946", 18:44:33 INFO - "pgo_build": "True", 18:44:33 INFO - "basedir": "/builds/slave/test", 18:44:33 INFO - "buildnumber": 311, 18:44:33 INFO - "slavename": "talos-linux64-ix-057", 18:44:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:44:33 INFO - "platform": "ubuntu64_hw", 18:44:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:44:33 INFO - "branch": "mozilla-aurora", 18:44:33 INFO - "repo_path": "releases/mozilla-aurora", 18:44:33 INFO - "revision": "0f66fd75014070ca82ddb8867bb85152d3d42484", 18:44:33 INFO - "stage_platform": "linux64-pgo", 18:44:33 INFO - "builduid": "209459d8cf2747b3b591f0d202dc4a09", 18:44:33 INFO - "slavebuilddir": "test" 18:44:33 INFO - } 18:44:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 18:44:33 INFO - Running post-action listener: _resource_record_post_action 18:44:33 INFO - ##### 18:44:33 INFO - ##### Running download-and-extract step. 18:44:33 INFO - ##### 18:44:33 INFO - Running pre-action listener: _resource_record_pre_action 18:44:33 INFO - Running main action method: download_and_extract 18:44:33 INFO - mkdir: /builds/slave/test/build/tests 18:44:33 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')]} 18:44:33 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:35 INFO - Downloaded 1361 bytes. 18:44:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:35 INFO - Using the following test package requirements: 18:44:35 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:35 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:35 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:44:35 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'jsshell-linux-x86_64.zip'], 18:44:35 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:35 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:35 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:44:35 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:44:35 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:35 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:35 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:35 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:44 INFO - Downloaded 23798585 bytes. 18:44:44 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'] 18:44:44 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 18:44:45 INFO - Return code: 0 18:44:45 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 18:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:45 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:47 INFO - Downloaded 23798585 bytes. 18:44:47 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'] 18:44:47 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 18:44:48 INFO - Return code: 0 18:44:48 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')]} 18:44:48 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:49 INFO - Downloaded 10840145 bytes. 18:44:49 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'] 18:44:49 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 18:44:49 INFO - Return code: 0 18:44: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')]} 18:44:49 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/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 18:44:50 INFO - Downloaded 62717137 bytes. 18:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:50 INFO - mkdir: /builds/slave/test/properties 18:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:50 INFO - Contents: 18:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:51 INFO - Running post-action listener: _resource_record_post_action 18:44:51 INFO - Running post-action listener: set_extra_try_arguments 18:44:51 INFO - ##### 18:44:51 INFO - ##### Running populate-webroot step. 18:44:51 INFO - ##### 18:44:51 INFO - Running pre-action listener: _resource_record_pre_action 18:44:51 INFO - Running main action method: populate_webroot 18:44:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:51 INFO - '--tppagecycles', 18:44:51 INFO - '7'], 18:44:51 INFO - 'tests': ['tsvgm']}}, 18:44:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['damp', 'tps']}, 18:44:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'tests': ['damp', 'tps']}, 18:44:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['dromaeo_dom']}, 18:44:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['a11yr', 18:44:51 INFO - 'ts_paint', 18:44:51 INFO - 'tpaint', 18:44:51 INFO - 'sessionrestore', 18:44:51 INFO - 'sessionrestore_no_auto_restore', 18:44:51 INFO - 'tabpaint']}, 18:44:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['tsvgx', 18:44:51 INFO - 'tsvgr_opacity', 18:44:51 INFO - 'tart', 18:44:51 INFO - 'tscrollx', 18:44:51 INFO - 'cart']}, 18:44:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:51 INFO - 'tsvgr_opacity', 18:44:51 INFO - 'tart', 18:44:51 INFO - 'tscrollx', 18:44:51 INFO - 'cart']}, 18:44:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'talos_options': ['--disable-e10s'], 18:44:51 INFO - 'tests': ['tp5o']}, 18:44:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'tests': ['tp5o']}, 18:44:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'talos_options': ['--disable-e10s', 18:44:51 INFO - '--xperf_path', 18:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:51 INFO - 'tests': ['tp5n']}, 18:44:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:51 INFO - 'talos_options': ['--xperf_path', 18:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:51 INFO - 'tests': ['tp5n']}}, 18:44:51 INFO - 'talos.zip': {'path': '', 18:44:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:51 INFO - Running post-action listener: _resource_record_post_action 18:44:51 INFO - ##### 18:44:51 INFO - ##### Running create-virtualenv step. 18:44:51 INFO - ##### 18:44:51 INFO - Running pre-action listener: _resource_record_pre_action 18:44:51 INFO - Running main action method: create_virtualenv 18:44:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:51 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 18:44:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:51 INFO - Using real prefix '/usr' 18:44:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:54 INFO - Installing pip.................done. 18:44:54 INFO - Return code: 0 18:44:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:54 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:44:54 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 18:44:54 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 18:44:54 INFO - Using env: {'DISPLAY': ':0', 18:44:54 INFO - 'HOME': '/home/cltbld', 18:44:54 INFO - 'LANG': 'en_US.UTF-8', 18:44:54 INFO - 'LANGUAGE': 'en_US:en', 18:44:54 INFO - 'LOGNAME': 'cltbld', 18:44:54 INFO - 'MAIL': '/var/mail/cltbld', 18:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:54 INFO - 'MOZ_NO_REMOTE': '1', 18:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:54 INFO - 'NO_EM_RESTART': '1', 18:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:54 INFO - 'PWD': '/builds/slave/test', 18:44:54 INFO - 'SHELL': '/bin/bash', 18:44:54 INFO - 'SHLVL': '1', 18:44:54 INFO - 'TERM': 'linux', 18:44:54 INFO - 'TMOUT': '86400', 18:44:54 INFO - 'USER': 'cltbld', 18:44:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:54 INFO - '_': '/tools/buildbot/bin/python'} 18:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:54 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 18:44:54 INFO - Cleaning up... 18:44:54 INFO - Return code: 0 18:44:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:54 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:44:54 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 18:44:54 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 18:44:54 INFO - Using env: {'DISPLAY': ':0', 18:44:54 INFO - 'HOME': '/home/cltbld', 18:44:54 INFO - 'LANG': 'en_US.UTF-8', 18:44:54 INFO - 'LANGUAGE': 'en_US:en', 18:44:54 INFO - 'LOGNAME': 'cltbld', 18:44:54 INFO - 'MAIL': '/var/mail/cltbld', 18:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:54 INFO - 'MOZ_NO_REMOTE': '1', 18:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:54 INFO - 'NO_EM_RESTART': '1', 18:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:54 INFO - 'PWD': '/builds/slave/test', 18:44:54 INFO - 'SHELL': '/bin/bash', 18:44:54 INFO - 'SHLVL': '1', 18:44:54 INFO - 'TERM': 'linux', 18:44:54 INFO - 'TMOUT': '86400', 18:44:54 INFO - 'USER': 'cltbld', 18:44:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:54 INFO - '_': '/tools/buildbot/bin/python'} 18:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:54 INFO - Downloading/unpacking psutil>=0.7.1 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:54 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 18:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:56 INFO - Installing collected packages: psutil 18:44:56 INFO - Running setup.py install for psutil 18:44:56 INFO - building 'psutil._psutil_linux' extension 18:44:56 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 18:44:56 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 18:44:56 INFO - building 'psutil._psutil_posix' extension 18:44:56 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 18:44:57 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 18:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:57 INFO - Successfully installed psutil 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:44:57 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 18:44:57 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 18:44:57 INFO - Using env: {'DISPLAY': ':0', 18:44:57 INFO - 'HOME': '/home/cltbld', 18:44:57 INFO - 'LANG': 'en_US.UTF-8', 18:44:57 INFO - 'LANGUAGE': 'en_US:en', 18:44:57 INFO - 'LOGNAME': 'cltbld', 18:44:57 INFO - 'MAIL': '/var/mail/cltbld', 18:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:57 INFO - 'MOZ_NO_REMOTE': '1', 18:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:57 INFO - 'NO_EM_RESTART': '1', 18:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:57 INFO - 'PWD': '/builds/slave/test', 18:44:57 INFO - 'SHELL': '/bin/bash', 18:44:57 INFO - 'SHLVL': '1', 18:44:57 INFO - 'TERM': 'linux', 18:44:57 INFO - 'TMOUT': '86400', 18:44:57 INFO - 'USER': 'cltbld', 18:44:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:57 INFO - '_': '/tools/buildbot/bin/python'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:59 INFO - Installing collected packages: mozsystemmonitor 18:44:59 INFO - Running setup.py install for mozsystemmonitor 18:44:59 INFO - Successfully installed mozsystemmonitor 18:44:59 INFO - Cleaning up... 18:44:59 INFO - Return code: 0 18:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44:59 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')]} 18:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:59 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')]} 18:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:59 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:44:59 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 18:44:59 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 18:44:59 INFO - Using env: {'DISPLAY': ':0', 18:44:59 INFO - 'HOME': '/home/cltbld', 18:44:59 INFO - 'LANG': 'en_US.UTF-8', 18:44:59 INFO - 'LANGUAGE': 'en_US:en', 18:44:59 INFO - 'LOGNAME': 'cltbld', 18:44:59 INFO - 'MAIL': '/var/mail/cltbld', 18:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:59 INFO - 'MOZ_NO_REMOTE': '1', 18:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:59 INFO - 'NO_EM_RESTART': '1', 18:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:59 INFO - 'PWD': '/builds/slave/test', 18:44:59 INFO - 'SHELL': '/bin/bash', 18:44:59 INFO - 'SHLVL': '1', 18:44:59 INFO - 'TERM': 'linux', 18:44:59 INFO - 'TMOUT': '86400', 18:44:59 INFO - 'USER': 'cltbld', 18:44:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:59 INFO - '_': '/tools/buildbot/bin/python'} 18:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:59 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 18:44:59 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 18:44:59 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 18:44:59 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 18:44:59 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 18:44:59 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 18:45:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:02 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 18:45:02 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 18:45:02 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 18:45:02 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 18:45:02 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 18:45:02 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 18:45:02 INFO - Downloading docopt-0.6.1.tar.gz 18:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:02 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:02 INFO - Running setup.py install for blobuploader 18:45:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:02 INFO - Running setup.py install for requests 18:45:03 INFO - Running setup.py install for docopt 18:45:03 INFO - Successfully installed blobuploader requests docopt 18:45:03 INFO - Cleaning up... 18:45:03 INFO - Return code: 0 18:45:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:03 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:45:03 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 18:45:03 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 18:45:03 INFO - Using env: {'DISPLAY': ':0', 18:45:03 INFO - 'HOME': '/home/cltbld', 18:45:03 INFO - 'LANG': 'en_US.UTF-8', 18:45:03 INFO - 'LANGUAGE': 'en_US:en', 18:45:03 INFO - 'LOGNAME': 'cltbld', 18:45:03 INFO - 'MAIL': '/var/mail/cltbld', 18:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:03 INFO - 'MOZ_NO_REMOTE': '1', 18:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:03 INFO - 'NO_EM_RESTART': '1', 18:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:03 INFO - 'PWD': '/builds/slave/test', 18:45:03 INFO - 'SHELL': '/bin/bash', 18:45:03 INFO - 'SHLVL': '1', 18:45:03 INFO - 'TERM': 'linux', 18:45:03 INFO - 'TMOUT': '86400', 18:45:03 INFO - 'USER': 'cltbld', 18:45:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:03 INFO - '_': '/tools/buildbot/bin/python'} 18:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:03 INFO - Running setup.py (path:/tmp/pip-1u6BEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:03 INFO - Running setup.py (path:/tmp/pip-CknSE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:03 INFO - Running setup.py (path:/tmp/pip-2EJx23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:03 INFO - Running setup.py (path:/tmp/pip-tMUcTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:03 INFO - Running setup.py (path:/tmp/pip-yXuc2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:03 INFO - Running setup.py (path:/tmp/pip-QmgoQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:03 INFO - Running setup.py (path:/tmp/pip-KfjO5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:03 INFO - Running setup.py (path:/tmp/pip-Tzc2Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:03 INFO - Running setup.py (path:/tmp/pip-qWVeTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:04 INFO - Running setup.py (path:/tmp/pip-TDFzMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:04 INFO - Running setup.py (path:/tmp/pip-xGeviq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:04 INFO - Running setup.py (path:/tmp/pip-37szF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:04 INFO - Running setup.py (path:/tmp/pip-XPOzX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:04 INFO - Running setup.py (path:/tmp/pip-k8hsjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:04 INFO - Running setup.py (path:/tmp/pip-O4R85w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:04 INFO - Running setup.py (path:/tmp/pip-TtCd67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:04 INFO - Running setup.py (path:/tmp/pip-91UaH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:04 INFO - Running setup.py install for manifestparser 18:45:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozcrash 18:45:04 INFO - Running setup.py install for mozdebug 18:45:04 INFO - Running setup.py install for mozdevice 18:45:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozfile 18:45:05 INFO - Running setup.py install for mozhttpd 18:45:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozinfo 18:45:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozInstall 18:45:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozleak 18:45:05 INFO - Running setup.py install for mozlog 18:45:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for moznetwork 18:45:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozprocess 18:45:05 INFO - Running setup.py install for mozprofile 18:45:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozrunner 18:45:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:06 INFO - Running setup.py install for mozscreenshot 18:45:06 INFO - Running setup.py install for moztest 18:45:06 INFO - Running setup.py install for mozversion 18:45:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:06 INFO - Cleaning up... 18:45:06 INFO - Return code: 0 18:45:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:06 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:45:06 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 18:45:06 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 18:45:06 INFO - Using env: {'DISPLAY': ':0', 18:45:06 INFO - 'HOME': '/home/cltbld', 18:45:06 INFO - 'LANG': 'en_US.UTF-8', 18:45:06 INFO - 'LANGUAGE': 'en_US:en', 18:45:06 INFO - 'LOGNAME': 'cltbld', 18:45:06 INFO - 'MAIL': '/var/mail/cltbld', 18:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:06 INFO - 'MOZ_NO_REMOTE': '1', 18:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:06 INFO - 'NO_EM_RESTART': '1', 18:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:06 INFO - 'PWD': '/builds/slave/test', 18:45:06 INFO - 'SHELL': '/bin/bash', 18:45:06 INFO - 'SHLVL': '1', 18:45:06 INFO - 'TERM': 'linux', 18:45:06 INFO - 'TMOUT': '86400', 18:45:06 INFO - 'USER': 'cltbld', 18:45:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:06 INFO - '_': '/tools/buildbot/bin/python'} 18:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:06 INFO - Running setup.py (path:/tmp/pip-qXlhu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:06 INFO - Running setup.py (path:/tmp/pip-8tTLZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:06 INFO - Running setup.py (path:/tmp/pip-KeC2uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:06 INFO - Running setup.py (path:/tmp/pip-OzUcn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:06 INFO - Running setup.py (path:/tmp/pip-bvmtis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:06 INFO - Running setup.py (path:/tmp/pip-9sDJhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:07 INFO - Running setup.py (path:/tmp/pip-2c5RwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:07 INFO - Running setup.py (path:/tmp/pip-IOQODC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:07 INFO - Running setup.py (path:/tmp/pip-xpzILw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:07 INFO - Running setup.py (path:/tmp/pip-3tsI16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:07 INFO - Running setup.py (path:/tmp/pip-sDhM57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:07 INFO - Running setup.py (path:/tmp/pip-ZKEPKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:07 INFO - Running setup.py (path:/tmp/pip-d7CBrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:07 INFO - Running setup.py (path:/tmp/pip-iiQUqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:07 INFO - Running setup.py (path:/tmp/pip-4lfDM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:07 INFO - Running setup.py (path:/tmp/pip-ZhiDCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:07 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)) 18:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:07 INFO - Running setup.py (path:/tmp/pip-WVtwOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:07 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)) 18:45:07 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)) 18:45:07 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)) 18:45:07 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)) 18:45:07 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)) 18:45:07 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)) 18:45:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:07 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 18:45:09 INFO - Downloading blessings-1.6.tar.gz 18:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:09 INFO - Installing collected packages: blessings 18:45:09 INFO - Running setup.py install for blessings 18:45:09 INFO - Successfully installed blessings 18:45:09 INFO - Cleaning up... 18:45:09 INFO - Return code: 0 18:45:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:10 INFO - Reading from file tmpfile_stdout 18:45:10 INFO - Current package versions: 18:45:10 INFO - argparse == 1.2.1 18:45:10 INFO - blessings == 1.6 18:45:10 INFO - blobuploader == 1.2.4 18:45:10 INFO - docopt == 0.6.1 18:45:10 INFO - manifestparser == 1.1 18:45:10 INFO - mozInstall == 1.12 18:45:10 INFO - mozcrash == 0.17 18:45:10 INFO - mozdebug == 0.1 18:45:10 INFO - mozdevice == 0.48 18:45:10 INFO - mozfile == 1.2 18:45:10 INFO - mozhttpd == 0.7 18:45:10 INFO - mozinfo == 0.9 18:45:10 INFO - mozleak == 0.1 18:45:10 INFO - mozlog == 3.1 18:45:10 INFO - moznetwork == 0.27 18:45:10 INFO - mozprocess == 0.22 18:45:10 INFO - mozprofile == 0.28 18:45:10 INFO - mozrunner == 6.11 18:45:10 INFO - mozscreenshot == 0.1 18:45:10 INFO - mozsystemmonitor == 0.0 18:45:10 INFO - moztest == 0.7 18:45:10 INFO - mozversion == 1.4 18:45:10 INFO - psutil == 3.1.1 18:45:10 INFO - requests == 1.2.3 18:45:10 INFO - wsgiref == 0.1.2 18:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:10 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:45:10 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 18:45:10 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 18:45:10 INFO - Using env: {'DISPLAY': ':0', 18:45:10 INFO - 'HOME': '/home/cltbld', 18:45:10 INFO - 'LANG': 'en_US.UTF-8', 18:45:10 INFO - 'LANGUAGE': 'en_US:en', 18:45:10 INFO - 'LOGNAME': 'cltbld', 18:45:10 INFO - 'MAIL': '/var/mail/cltbld', 18:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:10 INFO - 'MOZ_NO_REMOTE': '1', 18:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:10 INFO - 'NO_EM_RESTART': '1', 18:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:10 INFO - 'PWD': '/builds/slave/test', 18:45:10 INFO - 'SHELL': '/bin/bash', 18:45:10 INFO - 'SHLVL': '1', 18:45:10 INFO - 'TERM': 'linux', 18:45:10 INFO - 'TMOUT': '86400', 18:45:10 INFO - 'USER': 'cltbld', 18:45:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:10 INFO - '_': '/tools/buildbot/bin/python'} 18:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 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)) 18:45:10 INFO - Cleaning up... 18:45:10 INFO - Return code: 0 18:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:10 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 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:45:10 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 18:45:10 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 18:45:10 INFO - Using env: {'DISPLAY': ':0', 18:45:10 INFO - 'HOME': '/home/cltbld', 18:45:10 INFO - 'LANG': 'en_US.UTF-8', 18:45:10 INFO - 'LANGUAGE': 'en_US:en', 18:45:10 INFO - 'LOGNAME': 'cltbld', 18:45:10 INFO - 'MAIL': '/var/mail/cltbld', 18:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:10 INFO - 'MOZ_NO_REMOTE': '1', 18:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:10 INFO - 'NO_EM_RESTART': '1', 18:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:10 INFO - 'PWD': '/builds/slave/test', 18:45:10 INFO - 'SHELL': '/bin/bash', 18:45:10 INFO - 'SHLVL': '1', 18:45:10 INFO - 'TERM': 'linux', 18:45:10 INFO - 'TMOUT': '86400', 18:45:10 INFO - 'USER': 'cltbld', 18:45:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:10 INFO - '_': '/tools/buildbot/bin/python'} 18:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:10 INFO - Downloading/unpacking jsonschema 18:45:10 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 18:45:10 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 18:45:10 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 18:45:10 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 18:45:10 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 18:45:10 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 18:45:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:12 INFO - Downloading/unpacking functools32 (from jsonschema) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:12 INFO - warning: no files found matching '*.txt' 18:45:12 INFO - no previously-included directories found matching 'build' 18:45:12 INFO - no previously-included directories found matching 'dist' 18:45:12 INFO - no previously-included directories found matching '.git*' 18:45:12 INFO - Installing collected packages: jsonschema, functools32 18:45:12 INFO - Running setup.py install for functools32 18:45:12 INFO - warning: no files found matching '*.txt' 18:45:12 INFO - no previously-included directories found matching 'build' 18:45:12 INFO - no previously-included directories found matching 'dist' 18:45:12 INFO - no previously-included directories found matching '.git*' 18:45:13 INFO - Successfully installed jsonschema functools32 18:45:13 INFO - Cleaning up... 18:45:13 INFO - Return code: 0 18:45:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6187750f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', '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 18:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:45:13 INFO - Using env: {'DISPLAY': ':0', 18:45:13 INFO - 'HOME': '/home/cltbld', 18:45:13 INFO - 'LANG': 'en_US.UTF-8', 18:45:13 INFO - 'LANGUAGE': 'en_US:en', 18:45:13 INFO - 'LOGNAME': 'cltbld', 18:45:13 INFO - 'MAIL': '/var/mail/cltbld', 18:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:13 INFO - 'MOZ_NO_REMOTE': '1', 18:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:13 INFO - 'NO_EM_RESTART': '1', 18:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:13 INFO - 'PWD': '/builds/slave/test', 18:45:13 INFO - 'SHELL': '/bin/bash', 18:45:13 INFO - 'SHLVL': '1', 18:45:13 INFO - 'TERM': 'linux', 18:45:13 INFO - 'TMOUT': '86400', 18:45:13 INFO - 'USER': 'cltbld', 18:45:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:13 INFO - '_': '/tools/buildbot/bin/python'} 18:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:13 INFO - Downloading/unpacking flake8 18:45:13 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 18:45:13 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 18:45:13 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 18:45:13 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 18:45:13 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 18:45:13 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 18:45:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:45:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:45:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:15 INFO - no previously-included directories found matching 'docs/_build' 18:45:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:45:16 INFO - Running setup.py install for pep8 18:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:16 INFO - no previously-included directories found matching 'docs/_build' 18:45:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:45:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:45:16 INFO - Cleaning up... 18:45:16 INFO - Return code: 0 18:45:16 INFO - Running post-action listener: _resource_record_post_action 18:45:16 INFO - Running post-action listener: _start_resource_monitoring 18:45:16 INFO - Starting resource monitoring. 18:45:16 INFO - ##### 18:45:16 INFO - ##### Running install step. 18:45:16 INFO - ##### 18:45:16 INFO - Running pre-action listener: _resource_record_pre_action 18:45:16 INFO - Running main action method: install 18:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:16 INFO - Reading from file tmpfile_stdout 18:45:16 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:16 INFO - Reading from file tmpfile_stdout 18:45:16 INFO - Output received: 18:45:16 INFO - Usage: mozinstall [options] installer 18:45:16 INFO - Options: 18:45:16 INFO - -h, --help show this help message and exit 18:45:16 INFO - -d DEST, --destination=DEST 18:45:16 INFO - Directory to install application into. [default: 18:45:16 INFO - "/builds/slave/test"] 18:45:16 INFO - --app=APP Application being installed. [default: firefox] 18:45:16 INFO - mkdir: /builds/slave/test/build/application 18:45:16 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'] 18:45:16 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 18:45:32 INFO - Reading from file tmpfile_stdout 18:45:32 INFO - Output received: 18:45:32 INFO - /builds/slave/test/build/application/firefox/firefox 18:45:32 INFO - Running post-action listener: _resource_record_post_action 18:45:32 INFO - ##### 18:45:32 INFO - ##### Running run-tests step. 18:45:32 INFO - ##### 18:45:32 INFO - Running pre-action listener: _resource_record_pre_action 18:45:32 INFO - Running main action method: run_tests 18:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:32 INFO - Python 2.7.3 18:45:32 INFO - Return code: 0 18:45:32 INFO - grabbing minidump binary from tooltool 18:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:32 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 0x140a640>, '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 0x140b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140b9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:32 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 18:45:32 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 18:45:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:32 INFO - Return code: 0 18:45:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:45:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:45:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:45:33 INFO - Return code: 0 18:45:33 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:45:33 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 18:45:33 INFO - Using env: {'DISPLAY': ':0', 18:45:33 INFO - 'HOME': '/home/cltbld', 18:45:33 INFO - 'LANG': 'en_US.UTF-8', 18:45:33 INFO - 'LANGUAGE': 'en_US:en', 18:45:33 INFO - 'LOGNAME': 'cltbld', 18:45:33 INFO - 'MAIL': '/var/mail/cltbld', 18:45:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:33 INFO - 'MOZ_NO_REMOTE': '1', 18:45:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:33 INFO - 'NO_EM_RESTART': '1', 18:45:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:33 INFO - 'PWD': '/builds/slave/test', 18:45:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:33 INFO - 'SHELL': '/bin/bash', 18:45:33 INFO - 'SHLVL': '1', 18:45:33 INFO - 'TERM': 'linux', 18:45:33 INFO - 'TMOUT': '86400', 18:45:33 INFO - 'USER': 'cltbld', 18:45:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006', 18:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:33 INFO - '_': '/tools/buildbot/bin/python'} 18:45:33 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:45:33 INFO - mozversion application_buildid: 20160506160946 18:45:33 INFO - mozversion application_changeset: 0f66fd75014070ca82ddb8867bb85152d3d42484 18:45:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:45:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:33 INFO - mozversion application_name: Firefox 18:45:33 INFO - mozversion application_remotingname: firefox-dev 18:45:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:33 INFO - mozversion application_vendor: Mozilla 18:45:33 INFO - mozversion application_version: 48.0a2 18:45:33 INFO - mozversion platform_buildid: 20160506160946 18:45:33 INFO - mozversion platform_changeset: 0f66fd75014070ca82ddb8867bb85152d3d42484 18:45:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:33 INFO - mozversion platform_version: 48.0a2 18:45:33 INFO - using testdate: 1462585533 18:45:33 INFO - actual date: 1462585533 18:45:33 INFO - starting webserver on 'localhost:41186' 18:45:33 INFO - SUITE-START | Running 2 tests 18:45:33 INFO - TEST-START | dromaeo_css 18:45:33 INFO - operating with platform_type : linux_ 18:45:33 INFO - Initialising browser for dromaeo_css test... 18:45:33 INFO - TEST-INFO | started process 12650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphSd3AN/profile http://localhost:41186/getInfo.html) 18:45:37 INFO - PROCESS | 12650 | __metrics Screen width/height:1600/1200 18:45:37 INFO - PROCESS | 12650 | colorDepth:24 18:45:37 INFO - PROCESS | 12650 | Browser inner width/height: 1024/697 18:45:37 INFO - PROCESS | 12650 | __metrics 18:45:38 ERROR - PROCESS | 12650 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:45:39 INFO - TEST-INFO | 12650: exit 0 18:45:39 INFO - Browser initialized. 18:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:39 INFO - TEST-INFO | started process 12742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphSd3AN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:51 INFO - PROCESS | 12742 | RSS: Main: 142446592 18:45:51 INFO - PROCESS | 12742 | 18:46:42 INFO - PROCESS | 12742 | 1462585602682 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] 18:48:50 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41186/tests/dromaeo/cssquery-ext.html) 18:48:51 INFO - PROCESS | 12742 | RSS: Main: 251744256 18:48:51 INFO - PROCESS | 12742 | 18:51:53 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-ext.html (next: http://localhost:41186/tests/dromaeo/cssquery-jquery.html) 18:51:54 INFO - PROCESS | 12742 | RSS: Main: 221732864 18:51:54 INFO - PROCESS | 12742 | 18:54:56 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41186/tests/dromaeo/cssquery-mootools.html) 18:54:56 INFO - PROCESS | 12742 | RSS: Main: 222519296 18:54:56 INFO - PROCESS | 12742 | 18:57:58 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41186/tests/dromaeo/cssquery-prototype.html) 18:57:59 INFO - PROCESS | 12742 | RSS: Main: 214728704 18:57:59 INFO - PROCESS | 12742 | 19:01:01 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41186/tests/dromaeo/cssquery-yui.html) 19:01:02 INFO - PROCESS | 12742 | RSS: Main: 214110208 19:01:02 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | Cycle 1(1): loaded http://localhost:41186/tests/dromaeo/cssquery-yui.html (next: http://localhost:41186/tests/dromaeo/cssquery-dojo.html) 19:04:04 INFO - PROCESS | 12742 | RSS: Main: 258670592 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | __start_tp_report 19:04:04 INFO - PROCESS | 12742 | _x_x_mozilla_page_load 19:04:04 INFO - PROCESS | 12742 | _x_x_mozilla_page_load_details 19:04:04 INFO - PROCESS | 12742 | |i|pagename|runs| 19:04:04 INFO - PROCESS | 12742 | |0;dojo.html;3309.66903309669;3390.2033022239784;3409.079548521899;3416.4021296273145;3436.5876094868618;5561.5828812839045;5562.916556251655;5574.804881829137;5587.413321601234;5588.692621905793;5551.1673249012665;5606.327240731108;5606.327240731118;5615.691136987464;5648.576356773238;4848.466668666444;5053;5132.486751324856;5195.038917800201;5231.267622532849;4982.227754698028;5019.422766381858;5023;5024.522670346311;5027.798888044474;4950.678205916622;5063.189889617662;5131.923021154686;5150.304708864312;5158.329417175762;5095.184770436731;5101.2603172539775;5112.69323840567;5115.454704311149;5142.537171654531;4917.385326834145;4958.677685950402;5010.223415370623;5022.070916880389;5027.773750181214;5399.730013499348;5491.725413729338;5494.038543254915;5510.090835012218;5527.55779537636;5959.10613407988;5965.850853728692;5968.104784282349;5970.402959704038;5979.880402391927;5963.19496867926;6005.4895333896675;6054.061620448838;6060.757569697207;6068.544859135583;5521.309836270466;5578.693171875505;5580.693061881636;5615.298087739033;5660.29246344207;5924.8815023700145;6060.151578778975;6061.575689701678;6069.089636554552;6124.78563250293;5786.594938354359;5886.646801191942;5890.352061273256;5896.056630939029;5900.321463031806;5978.252718410199;5981.312149102909;5986.132010858401;5987.31145918225;5995.550333724988;5775.88448231033;5896.174535565025;5921.437463441052;5932.228810254639;5940;5908.704564771744;5989.431004054608;5990.400959904062;5991.7902873399225;6027.457528822427;4535.659825513034;4545.38637283969;4554.840580579664;4556.339330797082;4584.243599805995;3961.346377847623;3990.102226998902;4052.7365721228025;4082.8979275517754;4128.587141285908;5660.066089095253;5677.772889084473;5681.517071048925;5682.232898558642;5692.260006199251;5967.403259674084;5967.820965370959;5969.194158788508;5970.940290597038;5977.103434484775;5467.507924286833;5589.245451863946;5648.830535083954;5732.914006289909;5755.9424405756245;5049.26785616091;5061.519155680205;5062.493750624982;5062.493750624982;5064.392272927199;6133.693315334215;6136.048912418582;6142.170806941006;6142.508599312045;6143.723532441051;5750.511206547407;5905.675187864536;5966.731497082555;5999.730012149376;6003.369646187262;6164.445199932027;6166.876662466815;6168.660723660062;6171.197744293213;6177.6911154443;5660.660360378391;5907.054871220584;5916.792912248051;5920.496757775465;5923.733431995657;5884.35272120075;5924.555658325729;5941.940580594139;5947.434993675594;5986.491148252273;5849.64902105875;5874.118882167709;5878.059510478303;5882.176495290577;5885.440883116097;5595.244641973444;5798.362180160263;5804.21643078179;5844.064949608042;5874;5726.370099289158;5736.827895163152;5741.45456181662;5742.08126699726;5775.133729940542;5842.649441033552;5843.474087332161;5859.619124756877;5861.1501332307425;5867.178594996789;5561.944380556142;5691.943080569141;5722.685252311163;5736.397678243891;5813.302403711582 19:04:04 INFO - PROCESS | 12742 | |1;ext.html;664.4485077385767;668.411797618096;675.4596322941645;680.9421199198068;737.675422813962;36081.458778118315;39486;40122.59877401225;40214;40221.99999999996;43438.782806085925;43939.56060439395;44297;44326;44341;8545.786355341135;8862.60118294675;9049.140331668481;10364.689059328195;10602.681919542427;10689;10824.837627435594;10831;10833.241673082888;10846.620368287111;11046.226764126515;11124.944375278154;11128.777424451546;11132.165087618421;11133.387663678495;8456.112108228639;10667.679969600924;10845.620403285848;10845.83731244024;10848.67453976382;10764.838527422095;10865.728356791144;10868.891311086867;10870.61952831655;10871;40229;40383;40582.797086014674;40626.79686601578;40721.185576288306;3912.4913761211146;3984.442178095069;3984.5019372578427;4147.585241475858;4639.327297541871;34861.12847178816;34873;34887.65112348869;34938.825305873565;35241;4536.77316134192;4570.177368073745;4647.465541462708;4657.813687452498;4774.212254977924;225966;227971;228812;229296;229352.99999999834;39757.60242397539;40490.59509404868;67145.32854671488;68400.31599684039;68515;38480.23039539193;38562.614373856464;38638.420423693664;38689.2262154761;38763;16352.591185220464;17327.047012414187;17458.650826983645;17482.912585437247;17495.125243737763;14828.777568336483;15344.156071416179;15348.462803802036;15355.309011094527;15393.846061539465;9383.718488445358;9477.573509192103;9584.137427631547;9643.855342169873;9646.938836727953;3679.7608155469807;3717.925641487155;3756.417755247941;3761.887143385703;3766.5103536540073;1080.227637239362;1123.2262882748319;1127.4193790198055;1133.7335726104359;1205.764875849201;33106.33787324288;33947.151321216676;34096.488552671726;34233.657663423546;34959.825200873835;1211.6062279759115;1213.7997230457052;1218.451696736472;1227.1226073357593;1325.7282257137263;17420.303187872596;17604.383846565564;17959.102044897965;17994.280228790965;18165.36421225251;506751;511053;511788;511818;512726;62316;62602.686986565684;62641;62667;62813.685931570966;1402.537162736315;1509.0945432740268;1513.8637522623237;1522.9619259518379;1525.5804653720095;29703.55444668375;31116.68883311138;31364.529532056582;31595.21011974719;31762.364752705278;44554.55445445504;44833.327500086874;44925.55074449214;44980.32529511995;44985.10029799451;245271;247445;248139;248521;248761;30696.693033069383;40810.79594602008;41106.383404248365;41182.794086030575;47532.7623361881;36380.63619363772;46827;46952;47072;47509.762451187526;38395.42406863844;38904.416433754086;40729;41253.587464124976;41504.1699166009;39822.40266395948;40229;41232.58767412287;41313.79343103265;41485;41935.58064419317;42231.15537689291;42714.78642606767;43315.78342108269;43653.34519982267;36213.45679814752;36969.07577310589;37200.6279937208;37676;37853;29191;29192;29221;29297.267568310963;29354.70645293605 19:04:04 INFO - PROCESS | 12742 | |2;jquery.html;428.2358072542353;432.91125319309504;436.9126174765047;442.15548302741763;451.8124978134077;18699.06504674766;18804.52988675282;19355.70966435501;19439.708404373945;19536.90231548842;19127.42617721467;19376.806231937677;20631.896840515816;20654.277100301453;20670.17319307226;5431.321084864392;5710.200571919934;5710.7430165642645;5711.400302968191;5714.657120572758;4007.0783719744477;5576.553875689935;5640.5487560995025;5641.971790141043;5809.215755872945;5834.766609335621;5845.357010728838;5855;5860.033094539396;5862.853428664275;5630.718464076821;5754.597178197528;5756.453136951983;5808.506276966463;5837.357890632027;3854.094287842355;4011.7392369495888;5441.211024401479;5616.157576363578;5640.971795141039;13842.515511957134;13948.093373930764;14067.155970641794;14084;14169.22069286199;2464.8890799914047;2473.863937483438;2572.884220210095;2908.3746994396306;3095.347489961844;10462.633807816766;10495.475226238657;10805.783884322349;10823.621173258976;11482.196246262765;2061.6082944240698;2068.338131797825;2130.754963179223;2146.3668217875766;2150.9354719358444;81966.59016704938;82909.58545207296;83846;84459.57770211171;86034.56982715047;11171.94414027941;11289.774204516028;11353.60262390829;11421.086313094933;11557.479913403917;15963.680726385639;16006.359745610278;16123.596910077342;16157;16164.515064548083;9188.632454701738;9248.491332976617;9249.918768277084;9258.490783006864;9348.439093654266;9263.212626926652;9326.300527460331;9334.019927907608;9388.295877809192;9473.90526094744;4879.731614761222;4938.654294199371;4939.802407903716;4978.5270399312;5033.2701758245585;1799.635380772933;1948.620019096291;1951.4535929939639;2080.391931870913;2143.871367717942;955.861400096982;1044.8537204791335;1078.5254488025244;1083.5990683447176;1097.1058587251364;19233.422997310103;19364.322248721226;19376.515587110436;19391.2243510258;19752.506187345432;1036.6734478639205;1066.946652667379;1080.5191689698008;1091.579741799413;1099.5381939585393;10572.894271057345;11161.776764464828;11165.106791456665;11197.66407007791;11207.103431725442;498939;503273;514254;521074;524743;74811.62594187103;97540.51229743948;98812.50593746985;98932;99321;1029.7683021320142;1031.9174466042698;1040.4225654761528;1045.8535804987307;1082.5020490574425;17135.400260990806;17516;17623.03073330979;17772.91113544424;17936.461906142835;40155.59844401519;40734;40755.38866917058;41432;41467.37798932958;53058.2041269389;54543.454565455424;57257.71371143118;58840;59022.70488647701;8953.686620968236;9091.90908090937;9125.771855703395;9198.724038278862;9336.206422454168;9560.904390956;12676.683082923;13218.405171767487;13359.398827052612;13417.530386436818;10855.40295283767;11603.477843497232;11606.535738570701;11640;11877.406129693654;11611;11685.298882066763;11748.471318790504;11879.703007424883;11953.581624643444;11136.220464567403;11492.253003554742;11828.881711183123;11938.343391113573;12009;8856.291496680378;9005.234555062892;9015.278777697637;9041.50271735061;9182.632694692138;11435.59975400857;11467.885321147016;11805.468753906267;11991.460384282902;12186.878131218575 19:04:04 INFO - PROCESS | 12742 | |3;mootools.html;1453.7601295786196;1586.5716256610713;1605.9678806423872;1793.9103044847755;1908.3702378215191;7611.961940190298;8537.06092329844;8740;8746.169113934166;8764.605592748325;8471.322294216463;8571.442856214342;8650.783730406743;8651.178138076888;8652.178043085896;2108.156737305075;2145.302776597612;2410.349205714456;2468.0744720729726;2491.202815099169;2411.5176964607062;2426.4783071639595;2426.8665223412704;2427.514497100587;2428.259380888828;2375.774301441369;2387.7970372518357;2458.840175388594;2460.889259983296;2463.334899577113;2124.7981441763086;2352.117955766596;2401.447667036574;2408.2534414331612;2451.350392146074;2389.0682633772844;2396.113438027923;2431.732509423962;2435.6346548017764;2437.8049756019477;8560.957195213985;8614.698485553039;8616.741497755014;8616.827663446697;8625.956870215608;5476.123820188791;5612.438756124355;5616.241807355996;5643.407442218549;5644.491995720364;3547.467879818022;3548.787072775616;3636.418173092319;3643.708503319728;3673.3755261605593;1161.396074041502;1180.5749930025183;1181.4211036592008;1186.9406529673568;1241.5654520917606;12377.62867113979;12408.75182496354;12446.626601201979;12448.315342656151;12465.501379944792;4847.151748444008;4892.486288939681;4931.235658472942;4951.257311403247;4979.551840334388;10579.206559508068;10606.363618182933;10610.840837387444;10613.310134841211;10652.041316281571;5598.188262701886;5600.803971860965;5637.154426836008;5639.689817060019;5650.378458369576;4394.209042372339;5008.624353173526;5084.13569693153;5086.415062267813;5093.490650934877;4224.767637779952;4245.405643209953;4278.871633850989;4309.439772829513;4320.567943205654;1385.5635474825397;1394.6722520207743;1401.1523028567774;1406.9226192559508;1420.978685319721;878.2929741558107;999.9400035997863;1030.2479190191202;1038.678009816959;1073.2111897755144;5699.857503562361;5878.265216847894;6157.538184636171;6252.187215661935;6363.172787537591;480.37311308742426;486.350721786412;486.84664330735706;495.6901936289819;503.5845427522309;4276.486821581368;4381.452318460192;4382.298832186835;4386.254336762758;4421.9336709949375;10499.475026248658;10648.201384896163;10652.733681657866;10750.193735469871;10771.676849694522;10561.89438105609;10627.574897004033;10641.148708103334;10642.255042146975;10650.573977040987;7862.331701805296;7977.5612341321785;8050.919490805134;8058.717944871902;8074.717384891501;5924.11138329254;5980.34216236205;6060.515158787374;6111.816645500642;6286.654234017173;9252.95373523128;9394.81210375775;9548.37935534188;9593.808123837345;9594.280428967995;9371.34400591952;9608.231341492803;9689.41863488193;9709.27180461454;9928.404295742279;6936.514443988873;7127.82180445493;7543.283388078124;7595.468317217963;7732.342750866239;8233.629486673233;8241.917580824114;8276.627551760064;8284.46151000183;8299.958500207702;7352.816179595553;7385.9630701846145;7426.702931882664;7463.776086717407;7595.734149304748;7439.739609113655;7506.662200201114;7516.398688105048;7601.201873803392;7655.961720191363;7102.5028248022145;7145.964270178616;7155.892661609976;7233;7305.232950540117;5436.3476382834315;5464.480874316933;5565.387807341108;5595.916061259166;5646.661200327993;5288.81489147878;5382.569394448513;5453.372862120748;5505.642133261325;5516.613837031369 19:04:04 INFO - PROCESS | 12742 | |4;prototype.html;357.4566658678808;359.86505060602275;371.2667481723596;371.9851205951762;374.82008635854805;6249.71876265568;6281.99488081907;6284.057391391294;6289.496840252786;6295.055741638756;6129.233845769279;6220.564560480768;6244.250689917205;6249.250089989197;6255.249370075586;4550.817967281313;4650.581447669709;4661.5804577588015;4664.533546645325;4671.6262698984;4751.263554149095;4755.714657120584;4771.5467030632035;4772;4779.426468823729;4697.107549565571;4730.243161094226;4732.171869922767;4732.432108147027;4742.90514189716;4558.794854231567;4700.670953033289;4733.810647574093;4744.6441516886025;4746.4778874323965;4105.055837157441;4190.727602705814;4207.915841683149;4215.494140703105;4219.1139860629;5956.851078723023;5964.075568286922;5980.372060933583;5993.490553302974;5993.61041532299;5602.635828671123;5606.719664016783;5606.943930560724;5608.803691870765;5608.803691870806;6573.901391479084;6578.177727784027;6589.703463344161;6593.340665933369;6594.73621055162;4428.269335559628;4595.632349412039;4725.621950243973;4729.361536192604;4730.2431610942085;6853.965730171367;6876.896846547255;6905.965470172617;6921.238663746984;6928.515003949726;4687.20317546018;4717.268823332389;4718.339432479455;4726.220173671374;4727.858164255078;4770.260609605517;4777.880552986203;4783.402074740658;4786.7845946932475;4788.521147885183;5513.117901135879;5517.393086760453;5524.14375771756;5525.834224973257;5526.171074338881;6506.544541882023;6650.667466626746;6657.201135863727;6671.532992690562;6676.732930682719;1665.5503014186102;1670.9582260443342;1681.7141086015163;1684.2168391697674;1688.240291868664;1076.381080878498;1086.8424078508572;1097.429336744904;1122.8147355686383;1123.6067376418189;6175.69121543921;6339.651319177489;6428.742850285937;6490.188726409199;6509.479241660656;6872.347127023025;6923.861522769617;6929.5842249465195;6936.618485983218;6943.6875340609795;6435.839104022343;6445.16212892321;6446.580972236789;6447.097406363113;6448.1295025171;3689.1330537323706;3722.4230244312175;3725.925481490355;3731.7201209909367;3732.720045996561;7048.224695283515;7094.077769889985;7137.92862071383;7195.89206161908;7214.458915581353;6948.687309071104;7016.649167541705;7025.683844227022;7035.190953040364;7037.296270372922;7175.067241258707;7180;7180.676869540883;7191.748288809867;7194.568325900463;6899.448044156355;6917.27368626287;6942.271061538668;7001.159860816734;7002.649867506706;6588.308227636029;6820.522563420513;6820.965895170492;6835.14560679915;6848.828779280558;7122.430205583644;7164.856702866018;7172.175199852084;7185.784426467214;7207;4699.694519856198;4735.857924262277;4746.644001699818;4751.287306903992;4752.714837109785;6855.897161542481;6870.20992585859;6876.724931002704;6880.621565813728;6886.965565172142;6446.323136070832;6697.397234248941;6702.229243637044;6709.127813384229;6720.395164435225;6647;6662.666866656745;6663.600183988976;6690.163729533809;6692.933070669425;6491.156149700698;6528.804135875931;6562.606243625398;6571.211454625475;6579.572327798678;6738.528303018742;6755.527113102232;6755.763548275787;6757.087793147862;6760.087388202726;6439.162908821823;6533.607983521004;6538.509611779041;6570.310117437792;6574.079628851869 19:04:04 INFO - PROCESS | 12742 | |5;yui.html;896.4890012692764;911.8404279251131;944.8441007233806;950.3727539823718;952.1288021460364;15025.39898404064;15578.610534736623;15578.766318505232;15586.532404027868;15589.610259743513;12537.749245015095;13608.911287097033;13689.794653080211;13698.041137120406;14137.151770893754;905.6875377994597;908.609298001859;913.6528119314651;915.6154415145655;920.0155833258416;890.5591732092623;896.1307531694279;896.4890012692767;896.6278994217392;900.7883147460342;953.7234202081388;957.9089986451311;958.094600602431;958.6884262614643;959.2757468111566;944.3955868244295;950.5627411390768;951.8381875081253;951.9857202141939;953.8759961205034;697.3201128899283;698.3435570563654;701.3547536266647;701.4178232067422;703.3212949503753;13493.325333733274;13622.250776207306;13652.385642646104;13677.86322136776;13700;14005.579832605039;14032.71934561303;14138.929305353511;14178.291085445686;14282.143071415749;12370.62888113358;12546.372681365896;12640.115191936567;12802.295873726942;12963.28701921394;4554.4990051094355;4673.6027437667835;4680.7191568506;4730.952690473086;4764.094821983812;48037.55887323386;48652.78368040792;56653.716731416076;57353.139702904904;58173.41826581722;11624.302541847515;11661.591844285409;11673.88326116745;11864.22882512634;11958.760824783456;19533.609327813363;19590.412287631392;19600.901995490218;19608;19628.901855490632;8636.913630863737;8727.345449091343;8811.295096392274;8883.71931184981;8972.19250267479;4718.811247550128;4930.359053323117;4951.405831300267;5031;5049.040682270357;3665.908352291214;3695.9815200924363;3707.5550933888107;3707.6107008763693;3712;660.6927778582982;660.8314879705645;668.7458765669014;673.7574473189648;679.7281087565013;790.9723159689383;825.1830687619333;828.3704384667695;852.2117041736369;854.8076682746332;9840.311178217598;10186.185105191567;10326.48367581618;10520;10720.839187412195;563.8581871709739;596.5943158652071;846.817934144162;850.7277671145174;863.9438436501607;4735.550122738335;4744.359511465908;4761.857144285677;4762.567195619991;4913.778879950411;56904.43095569074;62804;62895.37104628987;62899.37100629027;63127.36872631215;54681.1797823033;55152.172717409274;55417.16874246889;55571.44428555744;56905;49382.75308623434;50056.749716251914;50630.74684626627;50943.745281274096;51113.744431277606;9940.502974851373;9964.950175249078;9983.800323993335;10012;10078.445685487368;36511.45232821563;37038;38238.80880595579;39114.2177156461;39199.608003919595;42983.355249670654;44380.778096109316;47903.5209647899;48177;48935.755321223165;12407.25556466615;12441.81758379766;12493.125481216228;12925.676858078623;13076.869231307564;14300.35648395804;14304.85695143077;14344.928275358974;14475.131492110508;14568.85431145675;12393.194442361579;12448.564300249447;12531.93734031324;12536.686582835502;13064.21614703121;13101.240934409358;13207.207567545978;13294.534691285759;13657.180569165881;13948.651283717989;13087.476500939856;13281;13753.79369309441;13762.449502019806;13820.93089534586;11127.666170014912;11501.82747258775;11596.188266821579;11830.05359571215;12114.21257618252;10708.678739637824;11085.334879907232;11092.611758588411;11122.388268645302;11152.832707509231 19:04:04 INFO - PROCESS | 12742 | __end_tp_report 19:04:04 INFO - PROCESS | 12742 | __start_cc_report 19:04:04 INFO - PROCESS | 12742 | _x_x_mozilla_cycle_collect,860 19:04:04 INFO - PROCESS | 12742 | __end_cc_report 19:04:04 INFO - PROCESS | 12742 | __startTimestamp1462586644751__endTimestamp 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | ------- Summary: start ------- 19:04:04 INFO - PROCESS | 12742 | Number of tests: 6 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#0] dojo.html Cycles:165 Average:5535.54 Median:5741.45 stddev:613.87 (10.7%) stddev-sans-first:590.40 19:04:04 INFO - PROCESS | 12742 | Values: 3309.7 3390.2 3409.1 3416.4 3436.6 5561.6 5562.9 5574.8 5587.4 5588.7 5551.2 5606.3 5606.3 5615.7 5648.6 4848.5 5053.0 5132.5 5195.0 5231.3 4982.2 5019.4 5023.0 5024.5 5027.8 4950.7 5063.2 5131.9 5150.3 5158.3 5095.2 5101.3 5112.7 5115.5 5142.5 4917.4 4958.7 5010.2 5022.1 5027.8 5399.7 5491.7 5494.0 5510.1 5527.6 5959.1 5965.9 5968.1 5970.4 5979.9 5963.2 6005.5 6054.1 6060.8 6068.5 5521.3 5578.7 5580.7 5615.3 5660.3 5924.9 6060.2 6061.6 6069.1 6124.8 5786.6 5886.6 5890.4 5896.1 5900.3 5978.3 5981.3 5986.1 5987.3 5995.6 5775.9 5896.2 5921.4 5932.2 5940.0 5908.7 5989.4 5990.4 5991.8 6027.5 4535.7 4545.4 4554.8 4556.3 4584.2 3961.3 3990.1 4052.7 4082.9 4128.6 5660.1 5677.8 5681.5 5682.2 5692.3 5967.4 5967.8 5969.2 5970.9 5977.1 5467.5 5589.2 5648.8 5732.9 5755.9 5049.3 5061.5 5062.5 5062.5 5064.4 6133.7 6136.0 6142.2 6142.5 6143.7 5750.5 5905.7 5966.7 5999.7 6003.4 6164.4 6166.9 6168.7 6171.2 6177.7 5660.7 5907.1 5916.8 5920.5 5923.7 5884.4 5924.6 5941.9 5947.4 5986.5 5849.6 5874.1 5878.1 5882.2 5885.4 5595.2 5798.4 5804.2 5844.1 5874.0 5726.4 5736.8 5741.5 5742.1 5775.1 5842.6 5843.5 5859.6 5861.2 5867.2 5561.9 5691.9 5722.7 5736.4 5813.3 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#1] ext.html Cycles:180 Average:50514.35 Median:3764.20 stddev:93717.91 (2489.7%) stddev-sans-first:93906.08 19:04:04 INFO - PROCESS | 12742 | Values: 664.4 668.4 675.5 680.9 737.7 36081.5 39486.0 40122.6 40214.0 40222.0 43438.8 43939.6 44297.0 44326.0 44341.0 8545.8 8862.6 9049.1 10364.7 10602.7 10689.0 10824.8 10831.0 10833.2 10846.6 11046.2 11124.9 11128.8 11132.2 11133.4 8456.1 10667.7 10845.6 10845.8 10848.7 10764.8 10865.7 10868.9 10870.6 10871.0 40229.0 40383.0 40582.8 40626.8 40721.2 3912.5 3984.4 3984.5 4147.6 4639.3 34861.1 34873.0 34887.7 34938.8 35241.0 4536.8 4570.2 4647.5 4657.8 4774.2 225966.0 227971.0 228812.0 229296.0 229353.0 39757.6 40490.6 67145.3 68400.3 68515.0 38480.2 38562.6 38638.4 38689.2 38763.0 16352.6 17327.0 17458.7 17482.9 17495.1 14828.8 15344.2 15348.5 15355.3 15393.8 9383.7 9477.6 9584.1 9643.9 9646.9 3679.8 3717.9 3756.4 3761.9 3766.5 1080.2 1123.2 1127.4 1133.7 1205.8 33106.3 33947.2 34096.5 34233.7 34959.8 1211.6 1213.8 1218.5 1227.1 1325.7 17420.3 17604.4 17959.1 17994.3 18165.4 506751.0 511053.0 511788.0 511818.0 512726.0 62316.0 62602.7 62641.0 62667.0 62813.7 1402.5 1509.1 1513.9 1523.0 1525.6 29703.6 31116.7 31364.5 31595.2 31762.4 44554.6 44833.3 44925.6 44980.3 44985.1 245271.0 247445.0 248139.0 248521.0 248761.0 30696.7 40810.8 41106.4 41182.8 47532.8 36380.6 46827.0 46952.0 47072.0 47509.8 38395.4 38904.4 40729.0 41253.6 41504.2 39822.4 40229.0 41232.6 41313.8 41485.0 41935.6 42231.2 42714.8 43315.8 43653.3 36213.5 36969.1 37200.6 37676.0 37853.0 29191.0 29192.0 29221.0 29297.3 29354.7 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#2] jquery.html Cycles:180 Average:29614.10 Median:2145.12 stddev:84475.76 (3938.0%) stddev-sans-first:84684.31 19:04:04 INFO - PROCESS | 12742 | Values: 428.2 432.9 436.9 442.2 451.8 18699.1 18804.5 19355.7 19439.7 19536.9 19127.4 19376.8 20631.9 20654.3 20670.2 5431.3 5710.2 5710.7 5711.4 5714.7 4007.1 5576.6 5640.5 5642.0 5809.2 5834.8 5845.4 5855.0 5860.0 5862.9 5630.7 5754.6 5756.5 5808.5 5837.4 3854.1 4011.7 5441.2 5616.2 5641.0 13842.5 13948.1 14067.2 14084.0 14169.2 2464.9 2473.9 2572.9 2908.4 3095.3 10462.6 10495.5 10805.8 10823.6 11482.2 2061.6 2068.3 2130.8 2146.4 2150.9 81966.6 82909.6 83846.0 84459.6 86034.6 11171.9 11289.8 11353.6 11421.1 11557.5 15963.7 16006.4 16123.6 16157.0 16164.5 9188.6 9248.5 9249.9 9258.5 9348.4 9263.2 9326.3 9334.0 9388.3 9473.9 4879.7 4938.7 4939.8 4978.5 5033.3 1799.6 1948.6 1951.5 2080.4 2143.9 955.9 1044.9 1078.5 1083.6 1097.1 19233.4 19364.3 19376.5 19391.2 19752.5 1036.7 1066.9 1080.5 1091.6 1099.5 10572.9 11161.8 11165.1 11197.7 11207.1 498939.0 503273.0 514254.0 521074.0 524743.0 74811.6 97540.5 98812.5 98932.0 99321.0 1029.8 1031.9 1040.4 1045.9 1082.5 17135.4 17516.0 17623.0 17772.9 17936.5 40155.6 40734.0 40755.4 41432.0 41467.4 53058.2 54543.5 57257.7 58840.0 59022.7 8953.7 9091.9 9125.8 9198.7 9336.2 9560.9 12676.7 13218.4 13359.4 13417.5 10855.4 11603.5 11606.5 11640.0 11877.4 11611.0 11685.3 11748.5 11879.7 11953.6 11136.2 11492.3 11828.9 11938.3 12009.0 8856.3 9005.2 9015.3 9041.5 9182.6 11435.6 11467.9 11805.5 11991.5 12186.9 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#3] mootools.html Cycles:180 Average:5809.43 Median:5085.28 stddev:3194.32 (62.8%) stddev-sans-first:3186.51 19:04:04 INFO - PROCESS | 12742 | Values: 1453.8 1586.6 1606.0 1793.9 1908.4 7612.0 8537.1 8740.0 8746.2 8764.6 8471.3 8571.4 8650.8 8651.2 8652.2 2108.2 2145.3 2410.3 2468.1 2491.2 2411.5 2426.5 2426.9 2427.5 2428.3 2375.8 2387.8 2458.8 2460.9 2463.3 2124.8 2352.1 2401.4 2408.3 2451.4 2389.1 2396.1 2431.7 2435.6 2437.8 8561.0 8614.7 8616.7 8616.8 8626.0 5476.1 5612.4 5616.2 5643.4 5644.5 3547.5 3548.8 3636.4 3643.7 3673.4 1161.4 1180.6 1181.4 1186.9 1241.6 12377.6 12408.8 12446.6 12448.3 12465.5 4847.2 4892.5 4931.2 4951.3 4979.6 10579.2 10606.4 10610.8 10613.3 10652.0 5598.2 5600.8 5637.2 5639.7 5650.4 4394.2 5008.6 5084.1 5086.4 5093.5 4224.8 4245.4 4278.9 4309.4 4320.6 1385.6 1394.7 1401.2 1406.9 1421.0 878.3 999.9 1030.2 1038.7 1073.2 5699.9 5878.3 6157.5 6252.2 6363.2 480.4 486.4 486.8 495.7 503.6 4276.5 4381.5 4382.3 4386.3 4421.9 10499.5 10648.2 10652.7 10750.2 10771.7 10561.9 10627.6 10641.1 10642.3 10650.6 7862.3 7977.6 8050.9 8058.7 8074.7 5924.1 5980.3 6060.5 6111.8 6286.7 9253.0 9394.8 9548.4 9593.8 9594.3 9371.3 9608.2 9689.4 9709.3 9928.4 6936.5 7127.8 7543.3 7595.5 7732.3 8233.6 8241.9 8276.6 8284.5 8300.0 7352.8 7386.0 7426.7 7463.8 7595.7 7439.7 7506.7 7516.4 7601.2 7656.0 7102.5 7146.0 7155.9 7233.0 7305.2 5436.3 5464.5 5565.4 5595.9 5646.7 5288.8 5382.6 5453.4 5505.6 5516.6 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#4] prototype.html Cycles:180 Average:5569.69 Median:6317.35 stddev:1689.84 (26.7%) stddev-sans-first:1648.67 19:04:04 INFO - PROCESS | 12742 | Values: 357.5 359.9 371.3 372.0 374.8 6249.7 6282.0 6284.1 6289.5 6295.1 6129.2 6220.6 6244.3 6249.3 6255.2 4550.8 4650.6 4661.6 4664.5 4671.6 4751.3 4755.7 4771.5 4772.0 4779.4 4697.1 4730.2 4732.2 4732.4 4742.9 4558.8 4700.7 4733.8 4744.6 4746.5 4105.1 4190.7 4207.9 4215.5 4219.1 5956.9 5964.1 5980.4 5993.5 5993.6 5602.6 5606.7 5606.9 5608.8 5608.8 6573.9 6578.2 6589.7 6593.3 6594.7 4428.3 4595.6 4725.6 4729.4 4730.2 6854.0 6876.9 6906.0 6921.2 6928.5 4687.2 4717.3 4718.3 4726.2 4727.9 4770.3 4777.9 4783.4 4786.8 4788.5 5513.1 5517.4 5524.1 5525.8 5526.2 6506.5 6650.7 6657.2 6671.5 6676.7 1665.6 1671.0 1681.7 1684.2 1688.2 1076.4 1086.8 1097.4 1122.8 1123.6 6175.7 6339.7 6428.7 6490.2 6509.5 6872.3 6923.9 6929.6 6936.6 6943.7 6435.8 6445.2 6446.6 6447.1 6448.1 3689.1 3722.4 3725.9 3731.7 3732.7 7048.2 7094.1 7137.9 7195.9 7214.5 6948.7 7016.6 7025.7 7035.2 7037.3 7175.1 7180.0 7180.7 7191.7 7194.6 6899.4 6917.3 6942.3 7001.2 7002.6 6588.3 6820.5 6821.0 6835.1 6848.8 7122.4 7164.9 7172.2 7185.8 7207.0 4699.7 4735.9 4746.6 4751.3 4752.7 6855.9 6870.2 6876.7 6880.6 6887.0 6446.3 6697.4 6702.2 6709.1 6720.4 6647.0 6662.7 6663.6 6690.2 6692.9 6491.2 6528.8 6562.6 6571.2 6579.6 6738.5 6755.5 6755.8 6757.1 6760.1 6439.2 6533.6 6538.5 6570.3 6574.1 19:04:04 INFO - PROCESS | 12742 | 19:04:04 INFO - PROCESS | 12742 | [#5] yui.html Cycles:180 Average:15301.86 Median:4699.77 stddev:17168.01 (365.3%) stddev-sans-first:17182.08 19:04:04 INFO - PROCESS | 12742 | Values: 896.5 911.8 944.8 950.4 952.1 15025.4 15578.6 15578.8 15586.5 15589.6 12537.7 13608.9 13689.8 13698.0 14137.2 905.7 908.6 913.7 915.6 920.0 890.6 896.1 896.5 896.6 900.8 953.7 957.9 958.1 958.7 959.3 944.4 950.6 951.8 952.0 953.9 697.3 698.3 701.4 701.4 703.3 13493.3 13622.3 13652.4 13677.9 13700.0 14005.6 14032.7 14138.9 14178.3 14282.1 12370.6 12546.4 12640.1 12802.3 12963.3 4554.5 4673.6 4680.7 4731.0 4764.1 48037.6 48652.8 56653.7 57353.1 58173.4 11624.3 11661.6 11673.9 11864.2 11958.8 19533.6 19590.4 19600.9 19608.0 19628.9 8636.9 8727.3 8811.3 8883.7 8972.2 4718.8 4930.4 4951.4 5031.0 5049.0 3665.9 3696.0 3707.6 3707.6 3712.0 660.7 660.8 668.7 673.8 679.7 791.0 825.2 828.4 852.2 854.8 9840.3 10186.2 10326.5 10520.0 10720.8 563.9 596.6 846.8 850.7 863.9 4735.6 4744.4 4761.9 4762.6 4913.8 56904.4 62804.0 62895.4 62899.4 63127.4 54681.2 55152.2 55417.2 55571.4 56905.0 49382.8 50056.7 50630.7 50943.7 51113.7 9940.5 9965.0 9983.8 10012.0 10078.4 36511.5 37038.0 38238.8 39114.2 39199.6 42983.4 44380.8 47903.5 48177.0 48935.8 12407.3 12441.8 12493.1 12925.7 13076.9 14300.4 14304.9 14344.9 14475.1 14568.9 12393.2 12448.6 12531.9 12536.7 13064.2 13101.2 13207.2 13294.5 13657.2 13948.7 13087.5 13281.0 13753.8 13762.4 13820.9 11127.7 11501.8 11596.2 11830.1 12114.2 10708.7 11085.3 11092.6 11122.4 11152.8 19:04:04 INFO - PROCESS | 12742 | -------- Summary: end -------- 19:04:04 INFO - PROCESS | 12742 | 19:04:05 INFO - TEST-INFO | 12742: exit 0 19:04:05 INFO - TEST-OK | dromaeo_css | took 1111700ms 19:04:05 INFO - TEST-START | kraken 19:04:05 INFO - operating with platform_type : linux_ 19:04:05 INFO - Initialising browser for kraken test... 19:04:05 INFO - TEST-INFO | started process 12932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyTn6F_/profile http://localhost:41186/getInfo.html) 19:04:09 INFO - PROCESS | 12932 | __metrics Screen width/height:1600/1200 19:04:09 INFO - PROCESS | 12932 | colorDepth:24 19:04:09 INFO - PROCESS | 12932 | Browser inner width/height: 1024/697 19:04:09 INFO - PROCESS | 12932 | __metrics 19:04:10 ERROR - PROCESS | 12932 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:04:11 INFO - TEST-INFO | 12932: exit 0 19:04:11 INFO - Browser initialized. 19:04:11 INFO - Running cycle 1/1 for kraken test... 19:04:11 INFO - TEST-INFO | started process 13024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyTn6F_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:22 INFO - PROCESS | 13024 | RSS: Main: 142180352 19:04:22 INFO - PROCESS | 13024 | 19:04:25 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41186/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:26 INFO - PROCESS | 13024 | RSS: Main: 197283840 19:04:26 INFO - PROCESS | 13024 | 19:04:28 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41186/tests/kraken/driver.html?testName=audio-dft) 19:04:29 INFO - PROCESS | 13024 | RSS: Main: 182104064 19:04:29 INFO - PROCESS | 13024 | 19:04:32 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41186/tests/kraken/driver.html?testName=audio-fft) 19:04:32 INFO - PROCESS | 13024 | RSS: Main: 273899520 19:04:32 INFO - PROCESS | 13024 | 19:04:34 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41186/tests/kraken/driver.html?testName=audio-oscillator) 19:04:35 INFO - PROCESS | 13024 | RSS: Main: 179838976 19:04:35 INFO - PROCESS | 13024 | 19:04:37 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:38 INFO - PROCESS | 13024 | RSS: Main: 178409472 19:04:38 INFO - PROCESS | 13024 | 19:04:41 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41186/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:41 INFO - PROCESS | 13024 | RSS: Main: 212819968 19:04:41 INFO - PROCESS | 13024 | 19:04:45 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41186/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:45 INFO - PROCESS | 13024 | RSS: Main: 213905408 19:04:45 INFO - PROCESS | 13024 | 19:04:48 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41186/tests/kraken/driver.html?testName=json-parse-financial) 19:04:49 INFO - PROCESS | 13024 | RSS: Main: 213147648 19:04:49 INFO - PROCESS | 13024 | 19:04:50 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:51 INFO - PROCESS | 13024 | RSS: Main: 195018752 19:04:51 INFO - PROCESS | 13024 | 19:04:52 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:53 INFO - PROCESS | 13024 | RSS: Main: 197763072 19:04:53 INFO - PROCESS | 13024 | 19:04:55 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:56 INFO - PROCESS | 13024 | RSS: Main: 209608704 19:04:56 INFO - PROCESS | 13024 | 19:04:58 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:59 INFO - PROCESS | 13024 | RSS: Main: 214548480 19:04:59 INFO - PROCESS | 13024 | 19:05:01 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:05:02 INFO - PROCESS | 13024 | RSS: Main: 210407424 19:05:02 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:41186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41186/tests/kraken/driver.html?testName=ai-astar) 19:05:04 INFO - PROCESS | 13024 | RSS: Main: 274391040 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | __start_tp_report 19:05:04 INFO - PROCESS | 13024 | _x_x_mozilla_page_load 19:05:04 INFO - PROCESS | 13024 | _x_x_mozilla_page_load_details 19:05:04 INFO - PROCESS | 13024 | |i|pagename|runs| 19:05:04 INFO - PROCESS | 13024 | |0;ai-astar;111;111;109;108;110;111;104;111;111;111 19:05:04 INFO - PROCESS | 13024 | |1;audio-beat-detection;152;126;152;174;127;156;156;130;186;127 19:05:04 INFO - PROCESS | 13024 | |2;audio-dft;163;160;160;161;159;159;159;160;163;159 19:05:04 INFO - PROCESS | 13024 | |3;audio-fft;76;77;75;182;75;75;72;76;157;75 19:05:04 INFO - PROCESS | 13024 | |4;audio-oscillator;93;92;154;92;98;93;149;93;93;145 19:05:04 INFO - PROCESS | 13024 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;116 19:05:04 INFO - PROCESS | 13024 | |6;imaging-darkroom;144;147;145;144;146;146;145;145;144;144 19:05:04 INFO - PROCESS | 13024 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 19:05:04 INFO - PROCESS | 13024 | |8;json-parse-financial;55;55;56;54;55;59;57;74;54;54 19:05:04 INFO - PROCESS | 13024 | |9;json-stringify-tinderbox;58;59;58;58;58;58;57;58;59;58 19:05:04 INFO - PROCESS | 13024 | |10;stanford-crypto-aes;72;72;72;72;73;73;72;74;73;73 19:05:04 INFO - PROCESS | 13024 | |11;stanford-crypto-ccm;117;111;113;119;115;132;114;111;132;135 19:05:04 INFO - PROCESS | 13024 | |12;stanford-crypto-pbkdf2;163;161;161;163;159;158;156;157;167;157 19:05:04 INFO - PROCESS | 13024 | |13;stanford-crypto-sha256-iterative;67;68;66;66;67;66;66;68;68;65 19:05:04 INFO - PROCESS | 13024 | __end_tp_report 19:05:04 INFO - PROCESS | 13024 | __start_cc_report 19:05:04 INFO - PROCESS | 13024 | _x_x_mozilla_cycle_collect,1611 19:05:04 INFO - PROCESS | 13024 | __end_cc_report 19:05:04 INFO - PROCESS | 13024 | __startTimestamp1462586704373__endTimestamp 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | ------- Summary: start ------- 19:05:04 INFO - PROCESS | 13024 | Number of tests: 14 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.35 19:05:04 INFO - PROCESS | 13024 | Values: 111.0 111.0 109.0 108.0 110.0 111.0 104.0 111.0 111.0 111.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.00 stddev:20.99 (13.6%) stddev-sans-first:22.23 19:05:04 INFO - PROCESS | 13024 | Values: 152.0 126.0 152.0 174.0 127.0 156.0 156.0 130.0 186.0 127.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.57 (1.0%) stddev-sans-first:1.32 19:05:04 INFO - PROCESS | 13024 | Values: 163.0 160.0 160.0 161.0 159.0 159.0 159.0 160.0 163.0 159.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:40.25 (53.7%) stddev-sans-first:42.16 19:05:04 INFO - PROCESS | 13024 | Values: 76.0 77.0 75.0 182.0 75.0 75.0 72.0 76.0 157.0 75.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:93.00 stddev:27.14 (29.2%) stddev-sans-first:28.06 19:05:04 INFO - PROCESS | 13024 | Values: 93.0 92.0 154.0 92.0 98.0 93.0 149.0 93.0 93.0 145.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:05:04 INFO - PROCESS | 13024 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 19:05:04 INFO - PROCESS | 13024 | Values: 144.0 147.0 145.0 144.0 146.0 146.0 145.0 145.0 144.0 144.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:05:04 INFO - PROCESS | 13024 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.50 stddev:6.07 (10.9%) stddev-sans-first:6.39 19:05:04 INFO - PROCESS | 13024 | Values: 55.0 55.0 56.0 54.0 55.0 59.0 57.0 74.0 54.0 54.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 19:05:04 INFO - PROCESS | 13024 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 57.0 58.0 59.0 58.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 19:05:04 INFO - PROCESS | 13024 | Values: 72.0 72.0 72.0 72.0 73.0 73.0 72.0 74.0 73.0 73.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:118.00 stddev:9.40 (8.0%) stddev-sans-first:9.91 19:05:04 INFO - PROCESS | 13024 | Values: 117.0 111.0 113.0 119.0 115.0 132.0 114.0 111.0 132.0 135.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:3.46 (2.1%) stddev-sans-first:3.52 19:05:04 INFO - PROCESS | 13024 | Values: 163.0 161.0 161.0 163.0 159.0 158.0 156.0 157.0 167.0 157.0 19:05:04 INFO - PROCESS | 13024 | 19:05:04 INFO - PROCESS | 13024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 19:05:04 INFO - PROCESS | 13024 | Values: 67.0 68.0 66.0 66.0 67.0 66.0 66.0 68.0 68.0 65.0 19:05:04 INFO - PROCESS | 13024 | -------- Summary: end -------- 19:05:04 INFO - PROCESS | 13024 | 19:05:05 INFO - TEST-INFO | 13024: exit 0 19:05:05 INFO - TEST-OK | kraken | took 59840ms 19:05:05 INFO - SUITE-END | took 1171s 19:05:05 INFO - Completed test suite (00:19:31) 19:05:05 INFO - javascript benchmark 19:05:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.66903309669, 3390.2033022239784, 3409.079548521899, 3416.4021296273145, 3436.5876094868618, 5561.5828812839045, 5562.916556251655, 5574.804881829137, 5587.413321601234, 5588.692621905793, 5551.1673249012665, 5606.327240731108, 5606.327240731118, 5615.691136987464, 5648.576356773238, 4848.466668666444, 5053.0, 5132.486751324856, 5195.038917800201, 5231.267622532849, 4982.227754698028, 5019.422766381858, 5023.0, 5024.522670346311, 5027.798888044474, 4950.678205916622, 5063.189889617662, 5131.923021154686, 5150.304708864312, 5158.329417175762, 5095.184770436731, 5101.2603172539775, 5112.69323840567, 5115.454704311149, 5142.537171654531, 4917.385326834145, 4958.677685950402, 5010.223415370623, 5022.070916880389, 5027.773750181214, 5399.730013499348, 5491.725413729338, 5494.038543254915, 5510.090835012218, 5527.55779537636, 5959.10613407988, 5965.850853728692, 5968.104784282349, 5970.402959704038, 5979.880402391927, 5963.19496867926, 6005.4895333896675, 6054.061620448838, 6060.757569697207, 6068.544859135583, 5521.309836270466, 5578.693171875505, 5580.693061881636, 5615.298087739033, 5660.29246344207, 5924.8815023700145, 6060.151578778975, 6061.575689701678, 6069.089636554552, 6124.78563250293, 5786.594938354359, 5886.646801191942, 5890.352061273256, 5896.056630939029, 5900.321463031806, 5978.252718410199, 5981.312149102909, 5986.132010858401, 5987.31145918225, 5995.550333724988, 5775.88448231033, 5896.174535565025, 5921.437463441052, 5932.228810254639, 5940.0, 5908.704564771744, 5989.431004054608, 5990.400959904062, 5991.7902873399225, 6027.457528822427, 4535.659825513034, 4545.38637283969, 4554.840580579664, 4556.339330797082, 4584.243599805995, 3961.346377847623, 3990.102226998902, 4052.7365721228025, 4082.8979275517754, 4128.587141285908, 5660.066089095253, 5677.772889084473, 5681.517071048925, 5682.232898558642, 5692.260006199251, 5967.403259674084, 5967.820965370959, 5969.194158788508, 5970.940290597038, 5977.103434484775, 5467.507924286833, 5589.245451863946, 5648.830535083954, 5732.914006289909, 5755.9424405756245, 5049.26785616091, 5061.519155680205, 5062.493750624982, 5062.493750624982, 5064.392272927199, 6133.693315334215, 6136.048912418582, 6142.170806941006, 6142.508599312045, 6143.723532441051, 5750.511206547407, 5905.675187864536, 5966.731497082555, 5999.730012149376, 6003.369646187262, 6164.445199932027, 6166.876662466815, 6168.660723660062, 6171.197744293213, 6177.6911154443, 5660.660360378391, 5907.054871220584, 5916.792912248051, 5920.496757775465, 5923.733431995657, 5884.35272120075, 5924.555658325729, 5941.940580594139, 5947.434993675594, 5986.491148252273, 5849.64902105875, 5874.118882167709, 5878.059510478303, 5882.176495290577, 5885.440883116097, 5595.244641973444, 5798.362180160263, 5804.21643078179, 5844.064949608042, 5874.0, 5726.370099289158, 5736.827895163152, 5741.45456181662, 5742.08126699726, 5775.133729940542, 5842.649441033552, 5843.474087332161, 5859.619124756877, 5861.1501332307425, 5867.178594996789, 5561.944380556142, 5691.943080569141, 5722.685252311163, 5736.397678243891, 5813.302403711582], "value": 5495.983310478234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.4485077385767, 668.411797618096, 675.4596322941645, 680.9421199198068, 737.675422813962, 36081.458778118315, 39486.0, 40122.59877401225, 40214.0, 40221.99999999996, 43438.782806085925, 43939.56060439395, 44297.0, 44326.0, 44341.0, 8545.786355341135, 8862.60118294675, 9049.140331668481, 10364.689059328195, 10602.681919542427, 10689.0, 10824.837627435594, 10831.0, 10833.241673082888, 10846.620368287111, 11046.226764126515, 11124.944375278154, 11128.777424451546, 11132.165087618421, 11133.387663678495, 8456.112108228639, 10667.679969600924, 10845.620403285848, 10845.83731244024, 10848.67453976382, 10764.838527422095, 10865.728356791144, 10868.891311086867, 10870.61952831655, 10871.0, 40229.0, 40383.0, 40582.797086014674, 40626.79686601578, 40721.185576288306, 3912.4913761211146, 3984.442178095069, 3984.5019372578427, 4147.585241475858, 4639.327297541871, 34861.12847178816, 34873.0, 34887.65112348869, 34938.825305873565, 35241.0, 4536.77316134192, 4570.177368073745, 4647.465541462708, 4657.813687452498, 4774.212254977924, 225966.0, 227971.0, 228812.0, 229296.0, 229352.99999999834, 39757.60242397539, 40490.59509404868, 67145.32854671488, 68400.31599684039, 68515.0, 38480.23039539193, 38562.614373856464, 38638.420423693664, 38689.2262154761, 38763.0, 16352.591185220464, 17327.047012414187, 17458.650826983645, 17482.912585437247, 17495.125243737763, 14828.777568336483, 15344.156071416179, 15348.462803802036, 15355.309011094527, 15393.846061539465, 9383.718488445358, 9477.573509192103, 9584.137427631547, 9643.855342169873, 9646.938836727953, 3679.7608155469807, 3717.925641487155, 3756.417755247941, 3761.887143385703, 3766.5103536540073, 1080.227637239362, 1123.2262882748319, 1127.4193790198055, 1133.7335726104359, 1205.764875849201, 33106.33787324288, 33947.151321216676, 34096.488552671726, 34233.657663423546, 34959.825200873835, 1211.6062279759115, 1213.7997230457052, 1218.451696736472, 1227.1226073357593, 1325.7282257137263, 17420.303187872596, 17604.383846565564, 17959.102044897965, 17994.280228790965, 18165.36421225251, 506751.0, 511053.0, 511788.0, 511818.0, 512726.0, 62316.0, 62602.686986565684, 62641.0, 62667.0, 62813.685931570966, 1402.537162736315, 1509.0945432740268, 1513.8637522623237, 1522.9619259518379, 1525.5804653720095, 29703.55444668375, 31116.68883311138, 31364.529532056582, 31595.21011974719, 31762.364752705278, 44554.55445445504, 44833.327500086874, 44925.55074449214, 44980.32529511995, 44985.10029799451, 245271.0, 247445.0, 248139.0, 248521.0, 248761.0, 30696.693033069383, 40810.79594602008, 41106.383404248365, 41182.794086030575, 47532.7623361881, 36380.63619363772, 46827.0, 46952.0, 47072.0, 47509.762451187526, 38395.42406863844, 38904.416433754086, 40729.0, 41253.587464124976, 41504.1699166009, 39822.40266395948, 40229.0, 41232.58767412287, 41313.79343103265, 41485.0, 41935.58064419317, 42231.15537689291, 42714.78642606767, 43315.78342108269, 43653.34519982267, 36213.45679814752, 36969.07577310589, 37200.6279937208, 37676.0, 37853.0, 29191.0, 29192.0, 29221.0, 29297.267568310963, 29354.70645293605], "value": 19669.17920984642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.2358072542353, 432.91125319309504, 436.9126174765047, 442.15548302741763, 451.8124978134077, 18699.06504674766, 18804.52988675282, 19355.70966435501, 19439.708404373945, 19536.90231548842, 19127.42617721467, 19376.806231937677, 20631.896840515816, 20654.277100301453, 20670.17319307226, 5431.321084864392, 5710.200571919934, 5710.7430165642645, 5711.400302968191, 5714.657120572758, 4007.0783719744477, 5576.553875689935, 5640.5487560995025, 5641.971790141043, 5809.215755872945, 5834.766609335621, 5845.357010728838, 5855.0, 5860.033094539396, 5862.853428664275, 5630.718464076821, 5754.597178197528, 5756.453136951983, 5808.506276966463, 5837.357890632027, 3854.094287842355, 4011.7392369495888, 5441.211024401479, 5616.157576363578, 5640.971795141039, 13842.515511957134, 13948.093373930764, 14067.155970641794, 14084.0, 14169.22069286199, 2464.8890799914047, 2473.863937483438, 2572.884220210095, 2908.3746994396306, 3095.347489961844, 10462.633807816766, 10495.475226238657, 10805.783884322349, 10823.621173258976, 11482.196246262765, 2061.6082944240698, 2068.338131797825, 2130.754963179223, 2146.3668217875766, 2150.9354719358444, 81966.59016704938, 82909.58545207296, 83846.0, 84459.57770211171, 86034.56982715047, 11171.94414027941, 11289.774204516028, 11353.60262390829, 11421.086313094933, 11557.479913403917, 15963.680726385639, 16006.359745610278, 16123.596910077342, 16157.0, 16164.515064548083, 9188.632454701738, 9248.491332976617, 9249.918768277084, 9258.490783006864, 9348.439093654266, 9263.212626926652, 9326.300527460331, 9334.019927907608, 9388.295877809192, 9473.90526094744, 4879.731614761222, 4938.654294199371, 4939.802407903716, 4978.5270399312, 5033.2701758245585, 1799.635380772933, 1948.620019096291, 1951.4535929939639, 2080.391931870913, 2143.871367717942, 955.861400096982, 1044.8537204791335, 1078.5254488025244, 1083.5990683447176, 1097.1058587251364, 19233.422997310103, 19364.322248721226, 19376.515587110436, 19391.2243510258, 19752.506187345432, 1036.6734478639205, 1066.946652667379, 1080.5191689698008, 1091.579741799413, 1099.5381939585393, 10572.894271057345, 11161.776764464828, 11165.106791456665, 11197.66407007791, 11207.103431725442, 498939.0, 503273.0, 514254.0, 521074.0, 524743.0, 74811.62594187103, 97540.51229743948, 98812.50593746985, 98932.0, 99321.0, 1029.7683021320142, 1031.9174466042698, 1040.4225654761528, 1045.8535804987307, 1082.5020490574425, 17135.400260990806, 17516.0, 17623.03073330979, 17772.91113544424, 17936.461906142835, 40155.59844401519, 40734.0, 40755.38866917058, 41432.0, 41467.37798932958, 53058.2041269389, 54543.454565455424, 57257.71371143118, 58840.0, 59022.70488647701, 8953.686620968236, 9091.90908090937, 9125.771855703395, 9198.724038278862, 9336.206422454168, 9560.904390956, 12676.683082923, 13218.405171767487, 13359.398827052612, 13417.530386436818, 10855.40295283767, 11603.477843497232, 11606.535738570701, 11640.0, 11877.406129693654, 11611.0, 11685.298882066763, 11748.471318790504, 11879.703007424883, 11953.581624643444, 11136.220464567403, 11492.253003554742, 11828.881711183123, 11938.343391113573, 12009.0, 8856.291496680378, 9005.234555062892, 9015.278777697637, 9041.50271735061, 9182.632694692138, 11435.59975400857, 11467.885321147016, 11805.468753906267, 11991.460384282902, 12186.878131218575], "value": 9356.537451789787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.7601295786196, 1586.5716256610713, 1605.9678806423872, 1793.9103044847755, 1908.3702378215191, 7611.961940190298, 8537.06092329844, 8740.0, 8746.169113934166, 8764.605592748325, 8471.322294216463, 8571.442856214342, 8650.783730406743, 8651.178138076888, 8652.178043085896, 2108.156737305075, 2145.302776597612, 2410.349205714456, 2468.0744720729726, 2491.202815099169, 2411.5176964607062, 2426.4783071639595, 2426.8665223412704, 2427.514497100587, 2428.259380888828, 2375.774301441369, 2387.7970372518357, 2458.840175388594, 2460.889259983296, 2463.334899577113, 2124.7981441763086, 2352.117955766596, 2401.447667036574, 2408.2534414331612, 2451.350392146074, 2389.0682633772844, 2396.113438027923, 2431.732509423962, 2435.6346548017764, 2437.8049756019477, 8560.957195213985, 8614.698485553039, 8616.741497755014, 8616.827663446697, 8625.956870215608, 5476.123820188791, 5612.438756124355, 5616.241807355996, 5643.407442218549, 5644.491995720364, 3547.467879818022, 3548.787072775616, 3636.418173092319, 3643.708503319728, 3673.3755261605593, 1161.396074041502, 1180.5749930025183, 1181.4211036592008, 1186.9406529673568, 1241.5654520917606, 12377.62867113979, 12408.75182496354, 12446.626601201979, 12448.315342656151, 12465.501379944792, 4847.151748444008, 4892.486288939681, 4931.235658472942, 4951.257311403247, 4979.551840334388, 10579.206559508068, 10606.363618182933, 10610.840837387444, 10613.310134841211, 10652.041316281571, 5598.188262701886, 5600.803971860965, 5637.154426836008, 5639.689817060019, 5650.378458369576, 4394.209042372339, 5008.624353173526, 5084.13569693153, 5086.415062267813, 5093.490650934877, 4224.767637779952, 4245.405643209953, 4278.871633850989, 4309.439772829513, 4320.567943205654, 1385.5635474825397, 1394.6722520207743, 1401.1523028567774, 1406.9226192559508, 1420.978685319721, 878.2929741558107, 999.9400035997863, 1030.2479190191202, 1038.678009816959, 1073.2111897755144, 5699.857503562361, 5878.265216847894, 6157.538184636171, 6252.187215661935, 6363.172787537591, 480.37311308742426, 486.350721786412, 486.84664330735706, 495.6901936289819, 503.5845427522309, 4276.486821581368, 4381.452318460192, 4382.298832186835, 4386.254336762758, 4421.9336709949375, 10499.475026248658, 10648.201384896163, 10652.733681657866, 10750.193735469871, 10771.676849694522, 10561.89438105609, 10627.574897004033, 10641.148708103334, 10642.255042146975, 10650.573977040987, 7862.331701805296, 7977.5612341321785, 8050.919490805134, 8058.717944871902, 8074.717384891501, 5924.11138329254, 5980.34216236205, 6060.515158787374, 6111.816645500642, 6286.654234017173, 9252.95373523128, 9394.81210375775, 9548.37935534188, 9593.808123837345, 9594.280428967995, 9371.34400591952, 9608.231341492803, 9689.41863488193, 9709.27180461454, 9928.404295742279, 6936.514443988873, 7127.82180445493, 7543.283388078124, 7595.468317217963, 7732.342750866239, 8233.629486673233, 8241.917580824114, 8276.627551760064, 8284.46151000183, 8299.958500207702, 7352.816179595553, 7385.9630701846145, 7426.702931882664, 7463.776086717407, 7595.734149304748, 7439.739609113655, 7506.662200201114, 7516.398688105048, 7601.201873803392, 7655.961720191363, 7102.5028248022145, 7145.964270178616, 7155.892661609976, 7233.0, 7305.232950540117, 5436.3476382834315, 5464.480874316933, 5565.387807341108, 5595.916061259166, 5646.661200327993, 5288.81489147878, 5382.569394448513, 5453.372862120748, 5505.642133261325, 5516.613837031369], "value": 4646.344526035911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.4566658678808, 359.86505060602275, 371.2667481723596, 371.9851205951762, 374.82008635854805, 6249.71876265568, 6281.99488081907, 6284.057391391294, 6289.496840252786, 6295.055741638756, 6129.233845769279, 6220.564560480768, 6244.250689917205, 6249.250089989197, 6255.249370075586, 4550.817967281313, 4650.581447669709, 4661.5804577588015, 4664.533546645325, 4671.6262698984, 4751.263554149095, 4755.714657120584, 4771.5467030632035, 4772.0, 4779.426468823729, 4697.107549565571, 4730.243161094226, 4732.171869922767, 4732.432108147027, 4742.90514189716, 4558.794854231567, 4700.670953033289, 4733.810647574093, 4744.6441516886025, 4746.4778874323965, 4105.055837157441, 4190.727602705814, 4207.915841683149, 4215.494140703105, 4219.1139860629, 5956.851078723023, 5964.075568286922, 5980.372060933583, 5993.490553302974, 5993.61041532299, 5602.635828671123, 5606.719664016783, 5606.943930560724, 5608.803691870765, 5608.803691870806, 6573.901391479084, 6578.177727784027, 6589.703463344161, 6593.340665933369, 6594.73621055162, 4428.269335559628, 4595.632349412039, 4725.621950243973, 4729.361536192604, 4730.2431610942085, 6853.965730171367, 6876.896846547255, 6905.965470172617, 6921.238663746984, 6928.515003949726, 4687.20317546018, 4717.268823332389, 4718.339432479455, 4726.220173671374, 4727.858164255078, 4770.260609605517, 4777.880552986203, 4783.402074740658, 4786.7845946932475, 4788.521147885183, 5513.117901135879, 5517.393086760453, 5524.14375771756, 5525.834224973257, 5526.171074338881, 6506.544541882023, 6650.667466626746, 6657.201135863727, 6671.532992690562, 6676.732930682719, 1665.5503014186102, 1670.9582260443342, 1681.7141086015163, 1684.2168391697674, 1688.240291868664, 1076.381080878498, 1086.8424078508572, 1097.429336744904, 1122.8147355686383, 1123.6067376418189, 6175.69121543921, 6339.651319177489, 6428.742850285937, 6490.188726409199, 6509.479241660656, 6872.347127023025, 6923.861522769617, 6929.5842249465195, 6936.618485983218, 6943.6875340609795, 6435.839104022343, 6445.16212892321, 6446.580972236789, 6447.097406363113, 6448.1295025171, 3689.1330537323706, 3722.4230244312175, 3725.925481490355, 3731.7201209909367, 3732.720045996561, 7048.224695283515, 7094.077769889985, 7137.92862071383, 7195.89206161908, 7214.458915581353, 6948.687309071104, 7016.649167541705, 7025.683844227022, 7035.190953040364, 7037.296270372922, 7175.067241258707, 7180.0, 7180.676869540883, 7191.748288809867, 7194.568325900463, 6899.448044156355, 6917.27368626287, 6942.271061538668, 7001.159860816734, 7002.649867506706, 6588.308227636029, 6820.522563420513, 6820.965895170492, 6835.14560679915, 6848.828779280558, 7122.430205583644, 7164.856702866018, 7172.175199852084, 7185.784426467214, 7207.0, 4699.694519856198, 4735.857924262277, 4746.644001699818, 4751.287306903992, 4752.714837109785, 6855.897161542481, 6870.20992585859, 6876.724931002704, 6880.621565813728, 6886.965565172142, 6446.323136070832, 6697.397234248941, 6702.229243637044, 6709.127813384229, 6720.395164435225, 6647.0, 6662.666866656745, 6663.600183988976, 6690.163729533809, 6692.933070669425, 6491.156149700698, 6528.804135875931, 6562.606243625398, 6571.211454625475, 6579.572327798678, 6738.528303018742, 6755.527113102232, 6755.763548275787, 6757.087793147862, 6760.087388202726, 6439.162908821823, 6533.607983521004, 6538.509611779041, 6570.310117437792, 6574.079628851869], "value": 5022.940912863604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.4890012692764, 911.8404279251131, 944.8441007233806, 950.3727539823718, 952.1288021460364, 15025.39898404064, 15578.610534736623, 15578.766318505232, 15586.532404027868, 15589.610259743513, 12537.749245015095, 13608.911287097033, 13689.794653080211, 13698.041137120406, 14137.151770893754, 905.6875377994597, 908.609298001859, 913.6528119314651, 915.6154415145655, 920.0155833258416, 890.5591732092623, 896.1307531694279, 896.4890012692767, 896.6278994217392, 900.7883147460342, 953.7234202081388, 957.9089986451311, 958.094600602431, 958.6884262614643, 959.2757468111566, 944.3955868244295, 950.5627411390768, 951.8381875081253, 951.9857202141939, 953.8759961205034, 697.3201128899283, 698.3435570563654, 701.3547536266647, 701.4178232067422, 703.3212949503753, 13493.325333733274, 13622.250776207306, 13652.385642646104, 13677.86322136776, 13700.0, 14005.579832605039, 14032.71934561303, 14138.929305353511, 14178.291085445686, 14282.143071415749, 12370.62888113358, 12546.372681365896, 12640.115191936567, 12802.295873726942, 12963.28701921394, 4554.4990051094355, 4673.6027437667835, 4680.7191568506, 4730.952690473086, 4764.094821983812, 48037.55887323386, 48652.78368040792, 56653.716731416076, 57353.139702904904, 58173.41826581722, 11624.302541847515, 11661.591844285409, 11673.88326116745, 11864.22882512634, 11958.760824783456, 19533.609327813363, 19590.412287631392, 19600.901995490218, 19608.0, 19628.901855490632, 8636.913630863737, 8727.345449091343, 8811.295096392274, 8883.71931184981, 8972.19250267479, 4718.811247550128, 4930.359053323117, 4951.405831300267, 5031.0, 5049.040682270357, 3665.908352291214, 3695.9815200924363, 3707.5550933888107, 3707.6107008763693, 3712.0, 660.6927778582982, 660.8314879705645, 668.7458765669014, 673.7574473189648, 679.7281087565013, 790.9723159689383, 825.1830687619333, 828.3704384667695, 852.2117041736369, 854.8076682746332, 9840.311178217598, 10186.185105191567, 10326.48367581618, 10520.0, 10720.839187412195, 563.8581871709739, 596.5943158652071, 846.817934144162, 850.7277671145174, 863.9438436501607, 4735.550122738335, 4744.359511465908, 4761.857144285677, 4762.567195619991, 4913.778879950411, 56904.43095569074, 62804.0, 62895.37104628987, 62899.37100629027, 63127.36872631215, 54681.1797823033, 55152.172717409274, 55417.16874246889, 55571.44428555744, 56905.0, 49382.75308623434, 50056.749716251914, 50630.74684626627, 50943.745281274096, 51113.744431277606, 9940.502974851373, 9964.950175249078, 9983.800323993335, 10012.0, 10078.445685487368, 36511.45232821563, 37038.0, 38238.80880595579, 39114.2177156461, 39199.608003919595, 42983.355249670654, 44380.778096109316, 47903.5209647899, 48177.0, 48935.755321223165, 12407.25556466615, 12441.81758379766, 12493.125481216228, 12925.676858078623, 13076.869231307564, 14300.35648395804, 14304.85695143077, 14344.928275358974, 14475.131492110508, 14568.85431145675, 12393.194442361579, 12448.564300249447, 12531.93734031324, 12536.686582835502, 13064.21614703121, 13101.240934409358, 13207.207567545978, 13294.534691285759, 13657.180569165881, 13948.651283717989, 13087.476500939856, 13281.0, 13753.79369309441, 13762.449502019806, 13820.93089534586, 11127.666170014912, 11501.82747258775, 11596.188266821579, 11830.05359571215, 12114.21257618252, 10708.678739637824, 11085.334879907232, 11092.611758588411, 11122.388268645302, 11152.832707509231], "value": 7212.69371353827, "unit": "score"}], "name": "dromaeo_css", "value": 7444.8948702118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 108.0, 110.0, 111.0, 104.0, 111.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 152.0, 174.0, 127.0, 156.0, 156.0, 130.0, 186.0, 127.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 159.0, 159.0, 159.0, 160.0, 163.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 182.0, 75.0, 75.0, 72.0, 76.0, 157.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 92.0, 98.0, 93.0, 149.0, 93.0, 93.0, 145.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 145.0, 144.0, 146.0, 146.0, 145.0, 145.0, 144.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 55.0, 59.0, 57.0, 74.0, 54.0, 54.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 72.0, 74.0, 73.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 113.0, 119.0, 115.0, 132.0, 114.0, 111.0, 132.0, 135.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 159.0, 158.0, 156.0, 157.0, 167.0, 157.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0, 68.0, 68.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1514.2, "alertThreshold": 2.0}]} 19:05:05 INFO - Return code: 0 19:05:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:05:05 ERROR - # TBPL SUCCESS # 19:05:05 INFO - Running post-action listener: _resource_record_post_action 19:05:05 INFO - Running post-run listener: _resource_record_post_run 19:05:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 274432; Write bytes: 501096448; Read time: 388; Write time: 512132 19:05:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 254812160; Read time: 208; Write time: 308156 19:05:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 246284288; Read time: 180; Write time: 203976 19:05:06 INFO - Running post-run listener: _upload_blobber_files 19:05:06 INFO - Blob upload gear active. 19:05:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05:06 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 19:05:06 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'] 19:05:06 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 19:05:07 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:05:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:08 INFO - (blobuploader) - INFO - Done attempting. 19:05:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:05:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:08 INFO - (blobuploader) - INFO - Done attempting. 19:05:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:08 INFO - Return code: 0 19:05:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efa722a3815bdd001c68ab92057067a4e5beecead2854e9f04996513b563555a7cdd9d8bdae6ed2fc80976937f99481e36bbeddcf813b1267dbc3f5085310b92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10060f0f56eec156aa52616ee9b8f51c9655c94ef88648c5bd536dba51ed1cdb79ffbc7ca959fed87db741bddb9eae934523597a7ea0457db58824db75a53940"} 19:05:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:08 INFO - Contents: 19:05:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/efa722a3815bdd001c68ab92057067a4e5beecead2854e9f04996513b563555a7cdd9d8bdae6ed2fc80976937f99481e36bbeddcf813b1267dbc3f5085310b92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10060f0f56eec156aa52616ee9b8f51c9655c94ef88648c5bd536dba51ed1cdb79ffbc7ca959fed87db741bddb9eae934523597a7ea0457db58824db75a53940"} 19:05:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:08 INFO - Copying logs to upload dir... 19:05:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.790982 ========= master_lag: 80.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-06 19:06:29.056817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 19:06:29.059851) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 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/efa722a3815bdd001c68ab92057067a4e5beecead2854e9f04996513b563555a7cdd9d8bdae6ed2fc80976937f99481e36bbeddcf813b1267dbc3f5085310b92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10060f0f56eec156aa52616ee9b8f51c9655c94ef88648c5bd536dba51ed1cdb79ffbc7ca959fed87db741bddb9eae934523597a7ea0457db58824db75a53940"} build_url:https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/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/efa722a3815bdd001c68ab92057067a4e5beecead2854e9f04996513b563555a7cdd9d8bdae6ed2fc80976937f99481e36bbeddcf813b1267dbc3f5085310b92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10060f0f56eec156aa52616ee9b8f51c9655c94ef88648c5bd536dba51ed1cdb79ffbc7ca959fed87db741bddb9eae934523597a7ea0457db58824db75a53940"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 19:06:29.354677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-05-06 19:06:29.354965) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1462585419.59442-788837006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 3.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-05-06 19:06:33.124961) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-05-06 19:06:33.125227) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-05-06 19:06:34.766811) ========= ========= Total master_lag: 84.19 =========